builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1456865297.53 results: success (0) buildid: 20160301120133 builduid: eb3ae1e5ffb64626a19c482bcf79acad revision: a88b9e9d747ac5f4f9c06db041057cd7b606b992 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:17.530598) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:17.531138) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:17.531487) ========= 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=0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004365 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:17.548598) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:17.548921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:17.561877) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:17.562229) ========= 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=0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004639 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:17.612127) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:17.612468) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:17.612882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:17.613233) ========= 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=0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 12:48:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-03-01 12:48:17 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153329 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:17.779262) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:17.779627) ========= 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=0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015059 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:17.829762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:17.830169) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a88b9e9d747ac5f4f9c06db041057cd7b606b992 --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 a88b9e9d747ac5f4f9c06db041057cd7b606b992 --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=0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 12:48:18,043 truncating revision to first 12 chars 2016-03-01 12:48:18,043 Setting DEBUG logging. 2016-03-01 12:48:18,043 attempt 1/10 2016-03-01 12:48:18,043 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a88b9e9d747a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 12:48:18,299 unpacking tar archive at: fx-team-a88b9e9d747a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558441 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:18.401765) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:18.402185) ========= echo a88b9e9d747ac5f4f9c06db041057cd7b606b992 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a88b9e9d747ac5f4f9c06db041057cd7b606b992'] 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=0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False a88b9e9d747ac5f4f9c06db041057cd7b606b992 program finished with exit code 0 elapsedTime=0.004689 script_repo_revision: 'a88b9e9d747ac5f4f9c06db041057cd7b606b992' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:18.452404) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:18.452696) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 12:48:18.463740) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-03-01 12:48:18.464035) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:48:18 INFO - MultiFileLogger online at 20160301 12:48:18 in /builds/slave/test 12:48:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:48:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:48:18 INFO - {'append_to_log': False, 12:48:18 INFO - 'base_work_dir': '/builds/slave/test', 12:48:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:48:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:48:18 INFO - 'branch': 'Fx-Team-Non-PGO', 12:48:18 INFO - 'buildbot_json_path': 'buildprops.json', 12:48:18 INFO - 'config_files': ('talos/linux_config.py',), 12:48:18 INFO - 'default_actions': ('clobber', 12:48:18 INFO - 'read-buildbot-config', 12:48:18 INFO - 'download-and-extract', 12:48:18 INFO - 'populate-webroot', 12:48:18 INFO - 'create-virtualenv', 12:48:18 INFO - 'install', 12:48:18 INFO - 'run-tests'), 12:48:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:48:18 INFO - 'download_minidump_stackwalk': True, 12:48:18 INFO - 'download_symbols': 'ondemand', 12:48:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:48:18 INFO - 'tooltool.py': '/tools/tooltool.py', 12:48:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:48:18 INFO - '/tools/misc-python/virtualenv.py')}, 12:48:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:48:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:48:18 INFO - 'installer_path': 'installer.exe', 12:48:18 INFO - 'log_level': 'info', 12:48:18 INFO - 'log_name': 'talos', 12:48:18 INFO - 'log_to_console': True, 12:48:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:48:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:48:18 INFO - 'opt_config_files': (), 12:48:18 INFO - 'pip_index': False, 12:48:18 INFO - 'sps_profile': False, 12:48:18 INFO - 'sps_profile_interval': 0, 12:48:18 INFO - 'suite': 'dromaeojs', 12:48:18 INFO - 'system_bits': '32', 12:48:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:48:18 INFO - 'title': 'talos-linux64-ix-017', 12:48:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:48:18 INFO - 'use_talos_json': True, 12:48:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:48:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:48:18 INFO - 'work_dir': 'build'} 12:48:18 INFO - ##### 12:48:18 INFO - ##### Running clobber step. 12:48:18 INFO - ##### 12:48:18 INFO - Running pre-action listener: _resource_record_pre_action 12:48:18 INFO - Running main action method: clobber 12:48:18 INFO - rmtree: /builds/slave/test/build 12:48:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:48:19 INFO - Running post-action listener: _resource_record_post_action 12:48:19 INFO - ##### 12:48:19 INFO - ##### Running read-buildbot-config step. 12:48:19 INFO - ##### 12:48:19 INFO - Running pre-action listener: _resource_record_pre_action 12:48:19 INFO - Running main action method: read_buildbot_config 12:48:19 INFO - Using buildbot properties: 12:48:19 INFO - { 12:48:19 INFO - "project": "", 12:48:19 INFO - "product": "firefox", 12:48:19 INFO - "script_repo_revision": "production", 12:48:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:48:19 INFO - "repository": "", 12:48:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:48:19 INFO - "buildid": "20160301120133", 12:48:19 INFO - "pgo_build": "False", 12:48:19 INFO - "basedir": "/builds/slave/test", 12:48:19 INFO - "buildnumber": 1402, 12:48:19 INFO - "slavename": "talos-linux64-ix-017", 12:48:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:48:19 INFO - "platform": "ubuntu64_hw", 12:48:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:48:19 INFO - "branch": "fx-team", 12:48:19 INFO - "repo_path": "integration/fx-team", 12:48:19 INFO - "revision": "a88b9e9d747ac5f4f9c06db041057cd7b606b992", 12:48:19 INFO - "stage_platform": "linux64", 12:48:19 INFO - "builduid": "eb3ae1e5ffb64626a19c482bcf79acad", 12:48:19 INFO - "slavebuilddir": "test" 12:48:19 INFO - } 12:48:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 12:48:19 INFO - Running post-action listener: _resource_record_post_action 12:48:19 INFO - ##### 12:48:19 INFO - ##### Running download-and-extract step. 12:48:19 INFO - ##### 12:48:19 INFO - Running pre-action listener: _resource_record_pre_action 12:48:19 INFO - Running main action method: download_and_extract 12:48:19 INFO - mkdir: /builds/slave/test/build/tests 12:48: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')]} 12:48:19 INFO - https://queue.taskcluster.net/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:48:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 12:48:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 12:48:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 12:48:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:48:19 INFO - Downloaded 1448 bytes. 12:48:19 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 12:48:19 INFO - Using the following test package requirements: 12:48:19 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:19 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:48:19 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:48:19 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:19 INFO - u'jsshell-linux-x86_64.zip'], 12:48:19 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:48:19 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:19 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:48:19 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:48:19 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:48:19 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 12:48:19 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:48:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:48:19 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:48: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')]} 12:48:19 INFO - https://queue.taskcluster.net/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:48:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 12:48:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 12:48:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/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 12:48:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/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 12:48:21 INFO - Downloaded 22077569 bytes. 12:48:21 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'] 12:48:21 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 12:48:22 INFO - Return code: 0 12:48:22 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 12:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:22 INFO - https://queue.taskcluster.net/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:48:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 12:48:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 12:48:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/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 12:48:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/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 12:48:23 INFO - Downloaded 22077569 bytes. 12:48:23 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'] 12:48:23 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 12:48:24 INFO - Return code: 0 12:48:24 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')]} 12:48:24 INFO - https://queue.taskcluster.net/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:48:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 12:48:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 12:48:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/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 12:48:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/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 12:48:26 INFO - Downloaded 10713413 bytes. 12:48:26 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'] 12:48:26 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 12:48:26 INFO - Return code: 0 12:48: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')]} 12:48:26 INFO - https://queue.taskcluster.net/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:48:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 12:48:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 12:48:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/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 12:48:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yj7AHdTtR7qv76_FmyM9VA/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 12:48:27 INFO - Downloaded 54379758 bytes. 12:48:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 12:48:27 INFO - mkdir: /builds/slave/test/properties 12:48:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:48:27 INFO - Writing to file /builds/slave/test/properties/build_url 12:48:27 INFO - Contents: 12:48:27 INFO - build_url:https://queue.taskcluster.net/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 12:48:28 INFO - Running post-action listener: _resource_record_post_action 12:48:28 INFO - Running post-action listener: set_extra_try_arguments 12:48:28 INFO - ##### 12:48:28 INFO - ##### Running populate-webroot step. 12:48:28 INFO - ##### 12:48:28 INFO - Running pre-action listener: _resource_record_pre_action 12:48:28 INFO - Running main action method: populate_webroot 12:48:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:48:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:48:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:48:28 INFO - '--tppagecycles', 12:48:28 INFO - '7'], 12:48:28 INFO - 'tests': ['tsvgm']}}, 12:48:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:48:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:48:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:48:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:48:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:48:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:48:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:28 INFO - 'talos_options': ['--e10s'], 12:48:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:48:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:28 INFO - 'tests': ['damp', 'tps']}, 12:48:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:28 INFO - 'talos_options': ['--e10s'], 12:48:28 INFO - 'tests': ['damp', 'tps']}, 12:48:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:48:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:48:28 INFO - 'other': {'tests': ['a11yr', 12:48:28 INFO - 'ts_paint', 12:48:28 INFO - 'tpaint', 12:48:28 INFO - 'sessionrestore', 12:48:28 INFO - 'sessionrestore_no_auto_restore']}, 12:48:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:48:28 INFO - 'tests': ['a11yr', 12:48:28 INFO - 'ts_paint', 12:48:28 INFO - 'tpaint', 12:48:28 INFO - 'sessionrestore', 12:48:28 INFO - 'sessionrestore_no_auto_restore']}, 12:48:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:48:28 INFO - 'tests': ['a11yr', 12:48:28 INFO - 'ts_paint', 12:48:28 INFO - 'tpaint', 12:48:28 INFO - 'sessionrestore', 12:48:28 INFO - 'sessionrestore_no_auto_restore']}, 12:48:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:48:28 INFO - 'tests': ['a11yr', 12:48:28 INFO - 'ts_paint', 12:48:28 INFO - 'tpaint', 12:48:28 INFO - 'sessionrestore', 12:48:28 INFO - 'sessionrestore_no_auto_restore']}, 12:48:28 INFO - 'other_l64': {'tests': ['a11yr', 12:48:28 INFO - 'ts_paint', 12:48:28 INFO - 'tpaint', 12:48:28 INFO - 'sessionrestore', 12:48:28 INFO - 'sessionrestore_no_auto_restore']}, 12:48:28 INFO - 'other_nol64': {'tests': ['a11yr', 12:48:28 INFO - 'ts_paint', 12:48:28 INFO - 'tpaint', 12:48:28 INFO - 'sessionrestore', 12:48:28 INFO - 'sessionrestore_no_auto_restore']}, 12:48:28 INFO - 'svgr': {'tests': ['tsvgx', 12:48:28 INFO - 'tsvgr_opacity', 12:48:28 INFO - 'tart', 12:48:28 INFO - 'tscrollx', 12:48:28 INFO - 'cart']}, 12:48:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:48:28 INFO - 'tests': ['tsvgx', 12:48:28 INFO - 'tsvgr_opacity', 12:48:28 INFO - 'tart', 12:48:28 INFO - 'tscrollx', 12:48:28 INFO - 'cart']}, 12:48:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:28 INFO - 'tests': ['tp5o']}, 12:48:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:28 INFO - 'talos_options': ['--e10s'], 12:48:28 INFO - 'tests': ['tp5o']}, 12:48:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:28 INFO - 'talos_options': ['--xperf_path', 12:48:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:28 INFO - 'tests': ['tp5n']}, 12:48:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:48:28 INFO - 'talos_options': ['--e10s', 12:48:28 INFO - '--xperf_path', 12:48:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:48:28 INFO - 'tests': ['tp5n']}}, 12:48:28 INFO - 'talos.zip': {'path': '', 12:48:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:48:28 INFO - Running post-action listener: _resource_record_post_action 12:48:28 INFO - ##### 12:48:28 INFO - ##### Running create-virtualenv step. 12:48:28 INFO - ##### 12:48:28 INFO - Running pre-action listener: _resource_record_pre_action 12:48:28 INFO - Running main action method: create_virtualenv 12:48:28 INFO - Creating virtualenv /builds/slave/test/build/venv 12:48:28 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 12:48:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:48:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:48:28 INFO - Using real prefix '/usr' 12:48:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:48:29 INFO - Installing distribute.............................................................................................................................................................................................done. 12:48:31 INFO - Installing pip.................done. 12:48:31 INFO - Return code: 0 12:48:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:48: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')]} 12:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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')]} 12:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f56aec94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cb3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a100>, '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 0x1a5b000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5b490>, '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': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', '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 12:48: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', 'pip>=1.5'] in /builds/slave/test/build 12:48: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 pip>=1.5 12:48:31 INFO - Using env: {'DISPLAY': ':0', 12:48:31 INFO - 'HOME': '/home/cltbld', 12:48:31 INFO - 'LANG': 'en_US.UTF-8', 12:48:31 INFO - 'LANGUAGE': 'en_US:en', 12:48:31 INFO - 'LOGNAME': 'cltbld', 12:48:31 INFO - 'MAIL': '/var/mail/cltbld', 12:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:31 INFO - 'MOZ_NO_REMOTE': '1', 12:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:31 INFO - 'NO_EM_RESTART': '1', 12:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:31 INFO - 'PWD': '/builds/slave/test', 12:48:31 INFO - 'SHELL': '/bin/bash', 12:48:31 INFO - 'SHLVL': '1', 12:48:31 INFO - 'TERM': 'linux', 12:48:31 INFO - 'TMOUT': '86400', 12:48:31 INFO - 'USER': 'cltbld', 12:48:31 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', 12:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:31 INFO - '_': '/tools/buildbot/bin/python'} 12:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:31 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 12:48:31 INFO - Cleaning up... 12:48:31 INFO - Return code: 0 12:48:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:48: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')]} 12:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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')]} 12:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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', '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 0x7f56aec94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cb3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a100>, '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 0x1a5b000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5b490>, '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': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', '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 12:48: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', 'psutil>=0.7.1'] in /builds/slave/test/build 12:48: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 psutil>=0.7.1 12:48:31 INFO - Using env: {'DISPLAY': ':0', 12:48:31 INFO - 'HOME': '/home/cltbld', 12:48:31 INFO - 'LANG': 'en_US.UTF-8', 12:48:31 INFO - 'LANGUAGE': 'en_US:en', 12:48:31 INFO - 'LOGNAME': 'cltbld', 12:48:31 INFO - 'MAIL': '/var/mail/cltbld', 12:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:31 INFO - 'MOZ_NO_REMOTE': '1', 12:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:31 INFO - 'NO_EM_RESTART': '1', 12:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:31 INFO - 'PWD': '/builds/slave/test', 12:48:31 INFO - 'SHELL': '/bin/bash', 12:48:31 INFO - 'SHLVL': '1', 12:48:31 INFO - 'TERM': 'linux', 12:48:31 INFO - 'TMOUT': '86400', 12:48:31 INFO - 'USER': 'cltbld', 12:48:31 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', 12:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:31 INFO - '_': '/tools/buildbot/bin/python'} 12:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:31 INFO - Downloading/unpacking psutil>=0.7.1 12:48:31 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 12:48:31 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 12:48:31 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 12:48:31 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 12:48:31 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 12:48:31 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 12:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:48:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:33 INFO - Installing collected packages: psutil 12:48:33 INFO - Running setup.py install for psutil 12:48:33 INFO - building 'psutil._psutil_linux' extension 12:48:33 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 12:48:33 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 12:48:33 INFO - building 'psutil._psutil_posix' extension 12:48:33 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 12:48:33 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 12:48:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:48:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:48:33 INFO - Successfully installed psutil 12:48:33 INFO - Cleaning up... 12:48:34 INFO - Return code: 0 12:48:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f56aec94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cb3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a100>, '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 0x1a5b000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5b490>, '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': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', '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 12:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:48:34 INFO - Using env: {'DISPLAY': ':0', 12:48:34 INFO - 'HOME': '/home/cltbld', 12:48:34 INFO - 'LANG': 'en_US.UTF-8', 12:48:34 INFO - 'LANGUAGE': 'en_US:en', 12:48:34 INFO - 'LOGNAME': 'cltbld', 12:48:34 INFO - 'MAIL': '/var/mail/cltbld', 12:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:34 INFO - 'MOZ_NO_REMOTE': '1', 12:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:34 INFO - 'NO_EM_RESTART': '1', 12:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:34 INFO - 'PWD': '/builds/slave/test', 12:48:34 INFO - 'SHELL': '/bin/bash', 12:48:34 INFO - 'SHLVL': '1', 12:48:34 INFO - 'TERM': 'linux', 12:48:34 INFO - 'TMOUT': '86400', 12:48:34 INFO - 'USER': 'cltbld', 12:48:34 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', 12:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:34 INFO - '_': '/tools/buildbot/bin/python'} 12:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:48:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:48:36 INFO - Installing collected packages: mozsystemmonitor 12:48:36 INFO - Running setup.py install for mozsystemmonitor 12:48:36 INFO - Successfully installed mozsystemmonitor 12:48:36 INFO - Cleaning up... 12:48:36 INFO - Return code: 0 12:48:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:48:36 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')]} 12:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:36 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')]} 12:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:36 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 0x7f56aec94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cb3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a100>, '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 0x1a5b000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5b490>, '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': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', '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 12:48:36 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 12:48:36 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 12:48:36 INFO - Using env: {'DISPLAY': ':0', 12:48:36 INFO - 'HOME': '/home/cltbld', 12:48:36 INFO - 'LANG': 'en_US.UTF-8', 12:48:36 INFO - 'LANGUAGE': 'en_US:en', 12:48:36 INFO - 'LOGNAME': 'cltbld', 12:48:36 INFO - 'MAIL': '/var/mail/cltbld', 12:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:36 INFO - 'MOZ_NO_REMOTE': '1', 12:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:36 INFO - 'NO_EM_RESTART': '1', 12:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:36 INFO - 'PWD': '/builds/slave/test', 12:48:36 INFO - 'SHELL': '/bin/bash', 12:48:36 INFO - 'SHLVL': '1', 12:48:36 INFO - 'TERM': 'linux', 12:48:36 INFO - 'TMOUT': '86400', 12:48:36 INFO - 'USER': 'cltbld', 12:48:36 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', 12:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:36 INFO - '_': '/tools/buildbot/bin/python'} 12:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:36 INFO - Downloading/unpacking blobuploader==1.2.4 12:48:36 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 12:48:36 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 12:48:36 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 12:48:36 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 12:48:36 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 12:48:36 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 12:48:38 INFO - Downloading blobuploader-1.2.4.tar.gz 12:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:48:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:48:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:38 INFO - Downloading docopt-0.6.1.tar.gz 12:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:48:39 INFO - Installing collected packages: blobuploader, requests, docopt 12:48:39 INFO - Running setup.py install for blobuploader 12:48:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:48:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:48:39 INFO - Running setup.py install for requests 12:48:39 INFO - Running setup.py install for docopt 12:48:39 INFO - Successfully installed blobuploader requests docopt 12:48:39 INFO - Cleaning up... 12:48:39 INFO - Return code: 0 12:48:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:39 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 0x7f56aec94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cb3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a100>, '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 0x1a5b000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5b490>, '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': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', '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 12:48:39 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 12:48:39 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 12:48:39 INFO - Using env: {'DISPLAY': ':0', 12:48:39 INFO - 'HOME': '/home/cltbld', 12:48:39 INFO - 'LANG': 'en_US.UTF-8', 12:48:39 INFO - 'LANGUAGE': 'en_US:en', 12:48:39 INFO - 'LOGNAME': 'cltbld', 12:48:39 INFO - 'MAIL': '/var/mail/cltbld', 12:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:39 INFO - 'MOZ_NO_REMOTE': '1', 12:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:39 INFO - 'NO_EM_RESTART': '1', 12:48:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:39 INFO - 'PWD': '/builds/slave/test', 12:48:39 INFO - 'SHELL': '/bin/bash', 12:48:39 INFO - 'SHLVL': '1', 12:48:39 INFO - 'TERM': 'linux', 12:48:39 INFO - 'TMOUT': '86400', 12:48:39 INFO - 'USER': 'cltbld', 12:48:39 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', 12:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:39 INFO - '_': '/tools/buildbot/bin/python'} 12:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:39 INFO - Running setup.py (path:/tmp/pip-OtijoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:39 INFO - Running setup.py (path:/tmp/pip-E0VqSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:40 INFO - Running setup.py (path:/tmp/pip-FojuOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:40 INFO - Running setup.py (path:/tmp/pip-mWukFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:40 INFO - Running setup.py (path:/tmp/pip-MghJkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:40 INFO - Running setup.py (path:/tmp/pip-PveOgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:40 INFO - Running setup.py (path:/tmp/pip-oYtTOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:40 INFO - Running setup.py (path:/tmp/pip-fsMnC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:40 INFO - Running setup.py (path:/tmp/pip-e6MCFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:40 INFO - Running setup.py (path:/tmp/pip-RxDQNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:40 INFO - Running setup.py (path:/tmp/pip-99aA_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:40 INFO - Running setup.py (path:/tmp/pip-7kLajJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:40 INFO - Running setup.py (path:/tmp/pip-HmuXHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:40 INFO - Running setup.py (path:/tmp/pip-x4aP4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:40 INFO - Running setup.py (path:/tmp/pip-SG3qzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:40 INFO - Running setup.py (path:/tmp/pip-RQh6s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:41 INFO - Running setup.py (path:/tmp/pip-2bYyra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:48:41 INFO - Running setup.py install for manifestparser 12:48:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:48:41 INFO - Running setup.py install for mozcrash 12:48:41 INFO - Running setup.py install for mozdebug 12:48:41 INFO - Running setup.py install for mozdevice 12:48:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:48:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:48:41 INFO - Running setup.py install for mozfile 12:48:41 INFO - Running setup.py install for mozhttpd 12:48:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:48:41 INFO - Running setup.py install for mozinfo 12:48:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:48:41 INFO - Running setup.py install for mozInstall 12:48:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:48:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:48:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:48:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:48:41 INFO - Running setup.py install for mozleak 12:48:41 INFO - Running setup.py install for mozlog 12:48:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:48:42 INFO - Running setup.py install for moznetwork 12:48:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:48:42 INFO - Running setup.py install for mozprocess 12:48:42 INFO - Running setup.py install for mozprofile 12:48:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:48:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:48:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:48:42 INFO - Running setup.py install for mozrunner 12:48:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:48:42 INFO - Running setup.py install for mozscreenshot 12:48:42 INFO - Running setup.py install for moztest 12:48:42 INFO - Running setup.py install for mozversion 12:48:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:48:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:48:42 INFO - Cleaning up... 12:48:42 INFO - Return code: 0 12:48:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48: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')]} 12:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48: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')]} 12:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:42 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 0x7f56aec94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cb3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a100>, '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 0x1a5b000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5b490>, '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': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', '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 12:48:42 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 12:48:42 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 12:48:42 INFO - Using env: {'DISPLAY': ':0', 12:48:42 INFO - 'HOME': '/home/cltbld', 12:48:42 INFO - 'LANG': 'en_US.UTF-8', 12:48:42 INFO - 'LANGUAGE': 'en_US:en', 12:48:42 INFO - 'LOGNAME': 'cltbld', 12:48:42 INFO - 'MAIL': '/var/mail/cltbld', 12:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:42 INFO - 'MOZ_NO_REMOTE': '1', 12:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:42 INFO - 'NO_EM_RESTART': '1', 12:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:42 INFO - 'PWD': '/builds/slave/test', 12:48:42 INFO - 'SHELL': '/bin/bash', 12:48:42 INFO - 'SHLVL': '1', 12:48:42 INFO - 'TERM': 'linux', 12:48:42 INFO - 'TMOUT': '86400', 12:48:42 INFO - 'USER': 'cltbld', 12:48:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', 12:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:42 INFO - '_': '/tools/buildbot/bin/python'} 12:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:48:43 INFO - Running setup.py (path:/tmp/pip-BB18yX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:48:43 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)) 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:48:43 INFO - Running setup.py (path:/tmp/pip-FbNX5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:48:43 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)) 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:48:43 INFO - Running setup.py (path:/tmp/pip-YD1Qt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:48:43 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)) 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:48:43 INFO - Running setup.py (path:/tmp/pip-gWxSUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:48:43 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)) 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:48:43 INFO - Running setup.py (path:/tmp/pip-jM9q3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:48:43 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)) 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:48:43 INFO - Running setup.py (path:/tmp/pip-4RNBjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:48:43 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)) 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:48:43 INFO - Running setup.py (path:/tmp/pip-ZNOvj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:48:43 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)) 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:48:43 INFO - Running setup.py (path:/tmp/pip-MyenNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:48:43 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)) 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:48:43 INFO - Running setup.py (path:/tmp/pip-va3l67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:48:43 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)) 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:48:43 INFO - Running setup.py (path:/tmp/pip-r6yM9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:48:43 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)) 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:48:43 INFO - Running setup.py (path:/tmp/pip-iqItgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:48:43 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)) 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:48:43 INFO - Running setup.py (path:/tmp/pip-FfIBBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:48:43 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)) 12:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:48:43 INFO - Running setup.py (path:/tmp/pip-ic0MV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:48:44 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)) 12:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:48:44 INFO - Running setup.py (path:/tmp/pip-rBwqpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:48:44 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)) 12:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:44 INFO - Running setup.py (path:/tmp/pip-a0ToGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:48:44 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)) 12:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:48:44 INFO - Running setup.py (path:/tmp/pip-cYPElv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:48:44 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)) 12:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:48:44 INFO - Running setup.py (path:/tmp/pip-eVoXWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:48:44 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)) 12:48:44 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)) 12:48:44 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)) 12:48:44 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)) 12:48:44 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)) 12:48:44 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)) 12:48:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:48:46 INFO - Downloading blessings-1.6.tar.gz 12:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:48:46 INFO - Installing collected packages: blessings 12:48:46 INFO - Running setup.py install for blessings 12:48:46 INFO - Successfully installed blessings 12:48:46 INFO - Cleaning up... 12:48:46 INFO - Return code: 0 12:48:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:48:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:46 INFO - Reading from file tmpfile_stdout 12:48:46 INFO - Current package versions: 12:48:46 INFO - argparse == 1.2.1 12:48:46 INFO - blessings == 1.6 12:48:46 INFO - blobuploader == 1.2.4 12:48:46 INFO - docopt == 0.6.1 12:48:46 INFO - manifestparser == 1.1 12:48:46 INFO - mozInstall == 1.12 12:48:46 INFO - mozcrash == 0.16 12:48:46 INFO - mozdebug == 0.1 12:48:46 INFO - mozdevice == 0.48 12:48:46 INFO - mozfile == 1.2 12:48:46 INFO - mozhttpd == 0.7 12:48:46 INFO - mozinfo == 0.9 12:48:46 INFO - mozleak == 0.1 12:48:46 INFO - mozlog == 3.1 12:48:46 INFO - moznetwork == 0.27 12:48:46 INFO - mozprocess == 0.22 12:48:46 INFO - mozprofile == 0.28 12:48:46 INFO - mozrunner == 6.11 12:48:46 INFO - mozscreenshot == 0.1 12:48:46 INFO - mozsystemmonitor == 0.0 12:48:46 INFO - moztest == 0.7 12:48:46 INFO - mozversion == 1.4 12:48:46 INFO - psutil == 3.1.1 12:48:46 INFO - requests == 1.2.3 12:48:46 INFO - wsgiref == 0.1.2 12:48:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:46 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 0x7f56aec94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cb3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a100>, '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 0x1a5b000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5b490>, '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': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', '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 12:48:46 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 12:48:46 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 12:48:46 INFO - Using env: {'DISPLAY': ':0', 12:48:46 INFO - 'HOME': '/home/cltbld', 12:48:46 INFO - 'LANG': 'en_US.UTF-8', 12:48:46 INFO - 'LANGUAGE': 'en_US:en', 12:48:46 INFO - 'LOGNAME': 'cltbld', 12:48:46 INFO - 'MAIL': '/var/mail/cltbld', 12:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:46 INFO - 'MOZ_NO_REMOTE': '1', 12:48:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:46 INFO - 'NO_EM_RESTART': '1', 12:48:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:46 INFO - 'PWD': '/builds/slave/test', 12:48:46 INFO - 'SHELL': '/bin/bash', 12:48:46 INFO - 'SHLVL': '1', 12:48:46 INFO - 'TERM': 'linux', 12:48:46 INFO - 'TMOUT': '86400', 12:48:46 INFO - 'USER': 'cltbld', 12:48:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', 12:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:46 INFO - '_': '/tools/buildbot/bin/python'} 12:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:46 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)) 12:48:46 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)) 12:48:46 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)) 12:48:46 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)) 12:48:46 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)) 12:48:46 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)) 12:48:46 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)) 12:48:46 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)) 12:48:46 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)) 12:48:46 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)) 12:48:46 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)) 12:48:46 INFO - Cleaning up... 12:48:46 INFO - Return code: 0 12:48:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:48:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:46 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 0x7f56aec94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cb3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a100>, '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 0x1a5b000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5b490>, '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': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', '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 12:48:46 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 12:48:46 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 12:48:46 INFO - Using env: {'DISPLAY': ':0', 12:48:46 INFO - 'HOME': '/home/cltbld', 12:48:46 INFO - 'LANG': 'en_US.UTF-8', 12:48:46 INFO - 'LANGUAGE': 'en_US:en', 12:48:46 INFO - 'LOGNAME': 'cltbld', 12:48:46 INFO - 'MAIL': '/var/mail/cltbld', 12:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:46 INFO - 'MOZ_NO_REMOTE': '1', 12:48:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:46 INFO - 'NO_EM_RESTART': '1', 12:48:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:46 INFO - 'PWD': '/builds/slave/test', 12:48:46 INFO - 'SHELL': '/bin/bash', 12:48:46 INFO - 'SHLVL': '1', 12:48:46 INFO - 'TERM': 'linux', 12:48:46 INFO - 'TMOUT': '86400', 12:48:46 INFO - 'USER': 'cltbld', 12:48:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', 12:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:46 INFO - '_': '/tools/buildbot/bin/python'} 12:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:47 INFO - Downloading/unpacking jsonschema 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:48: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 12:48:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:48:48 INFO - Downloading/unpacking functools32 (from jsonschema) 12:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:49 INFO - Downloading functools32-3.2.3-2.tar.gz 12:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:48:49 INFO - warning: no files found matching '*.txt' 12:48:49 INFO - no previously-included directories found matching 'build' 12:48:49 INFO - no previously-included directories found matching 'dist' 12:48:49 INFO - no previously-included directories found matching '.git*' 12:48:49 INFO - Installing collected packages: jsonschema, functools32 12:48:49 INFO - Running setup.py install for functools32 12:48:49 INFO - warning: no files found matching '*.txt' 12:48:49 INFO - no previously-included directories found matching 'build' 12:48:49 INFO - no previously-included directories found matching 'dist' 12:48:49 INFO - no previously-included directories found matching '.git*' 12:48:49 INFO - Successfully installed jsonschema functools32 12:48:49 INFO - Cleaning up... 12:48:49 INFO - Return code: 0 12:48:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:48:49 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')]} 12:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:49 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')]} 12:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:48:49 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 0x7f56aec94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19cb3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5a100>, '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 0x1a5b000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5b490>, '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': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', '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 12:48:49 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 12:48:49 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 12:48:49 INFO - Using env: {'DISPLAY': ':0', 12:48:49 INFO - 'HOME': '/home/cltbld', 12:48:49 INFO - 'LANG': 'en_US.UTF-8', 12:48:49 INFO - 'LANGUAGE': 'en_US:en', 12:48:49 INFO - 'LOGNAME': 'cltbld', 12:48:49 INFO - 'MAIL': '/var/mail/cltbld', 12:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:48:49 INFO - 'MOZ_NO_REMOTE': '1', 12:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:48:49 INFO - 'NO_EM_RESTART': '1', 12:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:48:49 INFO - 'PWD': '/builds/slave/test', 12:48:49 INFO - 'SHELL': '/bin/bash', 12:48:49 INFO - 'SHLVL': '1', 12:48:49 INFO - 'TERM': 'linux', 12:48:49 INFO - 'TMOUT': '86400', 12:48:49 INFO - 'USER': 'cltbld', 12:48:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', 12:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:48:49 INFO - '_': '/tools/buildbot/bin/python'} 12:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:48:49 INFO - Downloading/unpacking flake8 12:48:49 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 12:48:49 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 12:48:49 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 12:48:49 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 12:48:49 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 12:48:49 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 12:48:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:48:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:48:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:48:52 INFO - no previously-included directories found matching 'docs/_build' 12:48:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:48:52 INFO - Running setup.py install for pep8 12:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:48:52 INFO - no previously-included directories found matching 'docs/_build' 12:48:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:48:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:48:52 INFO - Cleaning up... 12:48:52 INFO - Return code: 0 12:48:52 INFO - Running post-action listener: _resource_record_post_action 12:48:52 INFO - Running post-action listener: _start_resource_monitoring 12:48:52 INFO - Starting resource monitoring. 12:48:52 INFO - ##### 12:48:52 INFO - ##### Running install step. 12:48:52 INFO - ##### 12:48:52 INFO - Running pre-action listener: _resource_record_pre_action 12:48:52 INFO - Running main action method: install 12:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:48:52 INFO - Reading from file tmpfile_stdout 12:48:52 INFO - Detecting whether we're running mozinstall >=1.0... 12:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:48:52 INFO - Reading from file tmpfile_stdout 12:48:52 INFO - Output received: 12:48:52 INFO - Usage: mozinstall [options] installer 12:48:52 INFO - Options: 12:48:52 INFO - -h, --help show this help message and exit 12:48:52 INFO - -d DEST, --destination=DEST 12:48:52 INFO - Directory to install application into. [default: 12:48:52 INFO - "/builds/slave/test"] 12:48:52 INFO - --app=APP Application being installed. [default: firefox] 12:48:52 INFO - mkdir: /builds/slave/test/build/application 12:48:52 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'] 12:48:52 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 12:49:08 INFO - Reading from file tmpfile_stdout 12:49:08 INFO - Output received: 12:49:08 INFO - /builds/slave/test/build/application/firefox/firefox 12:49:08 INFO - Running post-action listener: _resource_record_post_action 12:49:08 INFO - ##### 12:49:08 INFO - ##### Running run-tests step. 12:49:08 INFO - ##### 12:49:08 INFO - Running pre-action listener: _resource_record_pre_action 12:49:08 INFO - Running main action method: run_tests 12:49:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:49:08 INFO - Python 2.7.3 12:49:08 INFO - Return code: 0 12:49:08 INFO - grabbing minidump binary from tooltool 12:49: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')]} 12:49:08 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 0x1a5a100>, '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 0x1a5b000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5b490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:49:08 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 12:49:08 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 12:49:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:49:08 INFO - Return code: 0 12:49:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:49:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:49:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:49:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:49:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:49:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:49:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:49:09 INFO - Return code: 0 12:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:49:09 INFO - Using env: {'DISPLAY': ':0', 12:49:09 INFO - 'HOME': '/home/cltbld', 12:49:09 INFO - 'LANG': 'en_US.UTF-8', 12:49:09 INFO - 'LANGUAGE': 'en_US:en', 12:49:09 INFO - 'LOGNAME': 'cltbld', 12:49:09 INFO - 'MAIL': '/var/mail/cltbld', 12:49:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:49:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:49:09 INFO - 'MOZ_NO_REMOTE': '1', 12:49:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:49:09 INFO - 'NO_EM_RESTART': '1', 12:49:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:49:09 INFO - 'PWD': '/builds/slave/test', 12:49:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:49:09 INFO - 'SHELL': '/bin/bash', 12:49:09 INFO - 'SHLVL': '1', 12:49:09 INFO - 'TERM': 'linux', 12:49:09 INFO - 'TMOUT': '86400', 12:49:09 INFO - 'USER': 'cltbld', 12:49:09 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543', 12:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:49:09 INFO - '_': '/tools/buildbot/bin/python'} 12:49:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:49:09 INFO - mozversion application_buildid: 20160301120133 12:49:09 INFO - mozversion application_changeset: a88b9e9d747ac5f4f9c06db041057cd7b606b992 12:49:09 INFO - mozversion application_display_name: Nightly 12:49:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:49:09 INFO - mozversion application_name: Firefox 12:49:09 INFO - mozversion application_remotingname: firefox 12:49:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:49:09 INFO - mozversion application_vendor: Mozilla 12:49:09 INFO - mozversion application_version: 47.0a1 12:49:09 INFO - mozversion platform_buildid: 20160301120133 12:49:09 INFO - mozversion platform_changeset: a88b9e9d747ac5f4f9c06db041057cd7b606b992 12:49:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:49:09 INFO - mozversion platform_version: 47.0a1 12:49:09 INFO - using testdate: 1456865349 12:49:09 INFO - actual date: 1456865349 12:49:09 INFO - starting webserver on 'localhost:46476' 12:49:09 INFO - SUITE-START | Running 2 tests 12:49:09 INFO - TEST-START | dromaeo_css 12:49:09 INFO - operating with platform_type : linux_ 12:49:09 INFO - Initialising browser for dromaeo_css test... 12:49:09 INFO - TEST-INFO | started process 6208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJcZQc6/profile http://localhost:46476/getInfo.html) 12:49:13 INFO - PROCESS | 6208 | __metrics Screen width/height:1600/1200 12:49:13 INFO - PROCESS | 6208 | colorDepth:24 12:49:13 INFO - PROCESS | 6208 | Browser inner width/height: 1024/697 12:49:13 INFO - PROCESS | 6208 | __metrics 12:49:14 INFO - PROCESS | 6208 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:49:14 INFO - PROCESS | 6208 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 12:49:14 INFO - PROCESS | 6208 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 12:49:14 INFO - PROCESS | 6208 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 12:49:14 INFO - PROCESS | 6208 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 12:49:14 INFO - PROCESS | 6208 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 12:49:14 INFO - PROCESS | 6208 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 12:49:14 INFO - PROCESS | 6208 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 12:49:15 INFO - TEST-INFO | 6208: exit 0 12:49:15 INFO - Browser initialized. 12:49:15 INFO - Running cycle 1/1 for dromaeo_css test... 12:49:15 INFO - TEST-INFO | started process 6304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJcZQc6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:49:27 INFO - PROCESS | 6304 | RSS: Main: 153018368 12:49:27 INFO - PROCESS | 6304 | 12:50:18 INFO - PROCESS | 6304 | 1456865418337 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] 12:52:29 INFO - PROCESS | 6304 | Cycle 1(1): loaded http://localhost:46476/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46476/tests/dromaeo/cssquery-ext.html) 12:52:30 INFO - PROCESS | 6304 | RSS: Main: 233963520 12:52:30 INFO - PROCESS | 6304 | 12:55:32 INFO - PROCESS | 6304 | Cycle 1(1): loaded http://localhost:46476/tests/dromaeo/cssquery-ext.html (next: http://localhost:46476/tests/dromaeo/cssquery-jquery.html) 12:55:33 INFO - PROCESS | 6304 | RSS: Main: 238870528 12:55:33 INFO - PROCESS | 6304 | 12:58:35 INFO - PROCESS | 6304 | Cycle 1(1): loaded http://localhost:46476/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46476/tests/dromaeo/cssquery-mootools.html) 12:58:35 INFO - PROCESS | 6304 | RSS: Main: 235753472 12:58:35 INFO - PROCESS | 6304 | 13:01:37 INFO - PROCESS | 6304 | Cycle 1(1): loaded http://localhost:46476/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46476/tests/dromaeo/cssquery-prototype.html) 13:01:38 INFO - PROCESS | 6304 | RSS: Main: 218058752 13:01:38 INFO - PROCESS | 6304 | 13:04:41 INFO - PROCESS | 6304 | Cycle 1(1): loaded http://localhost:46476/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46476/tests/dromaeo/cssquery-yui.html) 13:04:41 INFO - PROCESS | 6304 | RSS: Main: 226017280 13:04:41 INFO - PROCESS | 6304 | 13:07:44 INFO - PROCESS | 6304 | Cycle 1(1): loaded http://localhost:46476/tests/dromaeo/cssquery-yui.html (next: http://localhost:46476/tests/dromaeo/cssquery-dojo.html) 13:07:44 INFO - PROCESS | 6304 | RSS: Main: 271024128 13:07:44 INFO - PROCESS | 6304 | 13:07:44 INFO - PROCESS | 6304 | __start_tp_report 13:07:44 INFO - PROCESS | 6304 | _x_x_mozilla_page_load 13:07:44 INFO - PROCESS | 6304 | _x_x_mozilla_page_load_details 13:07:44 INFO - PROCESS | 6304 | |i|pagename|runs| 13:07:44 INFO - PROCESS | 6304 | |0;dojo.html;2566.807489438292;2644.973550264498;2645.2328824640854;2656.7210442903493;2676.2238950704295;4383.232934236504;4456.376107344974;4492.213862574049;4496.685232033755;4520.977395113028;4478.529754375784;4497.527759585246;4507.4365704286965;4508.594226519621;4602.815887364502;4103.322951712964;4123;4128.504579450462;4206.47419072616;4248.872533823975;4172.97913510432;4183.267928112583;4198.0344520760245;4212.831486740527;4302.806373713191;4020.6381425671684;4123.2165888481095;4195.769232692201;4202.222588821078;4230.238557059728;4126.216018956418;4165.229432554987;4174.102567947906;4195.811188496525;4206.116715489751;3954.2486927483687;4114.403411505345;4135.90398544386;4142.2958097123565;4193.769342686151;4372.3878656988045;4440.067585806984;4509.458864936229;4529.071540334224;4530.728156310599;4789.425268967746;4805.063012712522;4814.759262036884;4816.903661926777;4859.635527335464;4840.588549973257;4842.588379987706;4847.878803029953;4849.393825771778;4892.168331383637;4362.345648152771;4469.798859051318;4530.569595888385;4560.087982403533;4569.54304569547;4863.367762190893;4900.705957642482;4907.1903135982875;4912.926306105412;4960.206366981266;4560.95439045612;4717.150912835654;4724.71651700899;4727.621790256771;4728.385309909759;4777.522247775264;4817.0606731686985;4819.373481447389;4856.028794241166;4862.708237505761;4748.501407352247;4756;4762.666613337033;4768.499307572724;4805.519448055236;4564.863054108382;4638.512956139624;4732.574068333797;4742.881427964328;4793.969296601247;4033.8184781684895;4067.736043833925;4084.6528045116497;4098.549159592442;4108.465899433055;3517.8065206413894;3541.0970202598173;3542.2738338640515;3550.591681956608;3582.5880023797076;4029.798510074543;4110.815013324408;4129.772862492592;4146.79266036703;4163.75017498951;4807.278908163734;4809.927851082237;4811.446683631427;4819;4870.4155501340065;4096.610821971908;4132.504099508018;4145.585441455831;4174.248635245685;4190.895227619334;4149.8962525937095;4246.44796176495;4276.957230427718;4320.373545835836;4335.588119128678;4577;4578.565036321477;4582.08358328329;4590.563896429834;4596.195665758546;4779.761011949458;4807.278908163804;4813.229883218668;4824.300476430828;4861.708297502161;4453.710508816916;4559.293309537027;4561.315802629632;4615.492295847387;4656.534346565317;4752.809887604457;4757.35775670294;4776.761161941959;4792.976035119802;4833.3958255218095;4831.057943700945;4839;4852.19938710123;4860.149473842134;4881.487443818348;4542.386777784956;4630.328602352707;4680.508546602694;4705.835295764632;4715.269133284346;4649.558291962258;4655.930161047655;4656.976715116538;4676.859694209179;4718.669693121586;4590.127875703739;4599.609033232213;4602.102589994919;4604.88487787808;4634.745089020136;4530.456345238593;4674.672772905864;4729.668923175483;4760.595349395202;4784.688995215439;4565.634749220121;4574.588287054181;4590.081983603226;4595.333676616805;4612.146752850734 13:07:44 INFO - PROCESS | 6304 | |1;ext.html;487.30802260789676;500.77715416639586;514.9819756308525;520.8854052108537;545.4845171313111;24523.632145517833;31912;32441.351172976527;32507.187320316974;32543.1864203395;34751;35121.12197195071;35145.82427087867;35167.648323516754;35211.4718279226;7497.212792656761;7600.087989441275;7699.538027718327;7701.9614901925415;7702.191269916662;7441.479096463249;7596.12644545876;7596.9240307596765;7602.353799926986;7770.912072309881;7739.419543534257;7799.220077992184;7814.452988290822;7838.882416763753;7849.411294152933;7727.690892364299;7761.185075567097;7795.259450352264;7801.8049548761455;7807.726729564438;7682.769516914502;7801.141874393869;7803.3367163791145;7807.219278072204;7809.180036096242;35673.64326356729;36066.278674426365;36118.63881361205;36119.458208126896;36132.81933590341;2735.5076086304457;3149.1497295730023;3168.2237851726245;3216.115394180552;3302.93394132116;27120;27374.589381159298;27519.587424377587;27647.30881727953;28004.579931301047;3237.287796684749;3397.6602339766073;3402.4896265560114;3441.587009558869;3446.5691788526433;241590;242126;242422;242592;242654;50332;52216.73891630518;52450.737746311024;52463.213051804254;52499.21251181235;56538.71730641321;56767.71616141893;57090.14364784532;57185;57318.71340643353;10403.84394234087;10481.161507079567;10541.631042913461;10607.522661480098;10617.469126543641;8109.391795615353;8112.148224436467;8167.754967350989;8226.218509241613;8426.915730842737;17613.47159585189;17688.55778605545;17688.823111768717;17709;17718;7087.433005359559;7246.746363877344;7249.492535522463;7294.525855819355;7338.559686418832;715.9713611455587;728.7158008376738;821.757581513455;914.3919293669768;938.6761567259421;23554.528909421715;23606.29181124569;23629;24657;24829.25512234636;841.7264389073454;843.4644001059371;891.8038031633031;1006.4414250091123;1028.1723212813756;12768.6807829805;12792;12973.156744811557;12998.740025199442;13036.674083147807;318524.4073779616;323518;324096;324109;325117;45662.77168614202;46217.76891115523;46238.30642540364;46245.53754462479;46277.76861115673;1001.379144930148;1076.8277075667856;1104.5195340027115;1112.527175950218;1203.7592481503734;23889.402764931016;24779.380515487257;25057.373565661004;25068.498630026934;25081.122160724288;33738.83130584331;34356.656433435346;34417;34422.82788586041;34475.65524344725;161978;163077;163086;163223;163230;24225.51548969046;29105.854470728358;29134.854325728236;29179.85410072936;29345.85327073351;34492.13769655779;34826.303473930886;34933.301333973686;35178.29643407066;35218.64781352256;30057.248568785955;30527.694723053373;30728;30905.536416953313;30982.380352393277;30360.84819575888;30507.84746076344;31008.379832402774;31047.68952310448;31203;30252;30450;30850.845745771127;30885.536716949715;30959.226019348796;27132.457350852477;27321.86339068292;27805.860970695016;27916.720832792224;28200.85899570489;21451.356459306247;22283.665745013514;22382.88808556012;22511.662325064808;22546.21088261903 13:07:44 INFO - PROCESS | 6304 | |2;jquery.html;304.9481588130018;314.49680511182095;314.84415214468834;316.4525371107983;319.59890337626274;11675;13961.44154233832;14740.926295368521;15299.464518741846;15329.92335038326;10216.795664086714;10576.682699519008;10597.258191926569;10598.046175844172;13716;4682.461516925563;4824.927626085611;4839.612830973514;4851.611871050308;4852.320675105488;4647.32613771003;4755.785989630458;4788.832390866321;4868.318435419044;4870.464248932614;3407.5910890693153;4726.763661816913;5357.142857142858;5540.307461567304;5551.1118221084635;5511.366192887789;5522.392536820947;5523.337199536061;5537.750801213955;5550.639208451458;4711.128441238382;4766.142094423002;4823.927641085386;4833.661643684944;4837.274408838667;17603.383881564085;18143.092845357678;18160.27358905642;18250.63498730018;18306.450806475827;1822.480593030993;1836.7612210412694;1872.17624245333;1894.6210757848485;1911.627232689626;11257.605983790529;11736.178467507278;11995.880041199563;12211.816822747665;12282.938585307016;1711.820258872813;1717.3302412059306;1718.6734520441075;1787.9642407151914;1793.0944872839132;49114.50885491135;50920.74539627278;50931;51865.74067129678;54756.452435475534;8717.084706105894;9074.45553266806;9339.953300233592;9506.429614223169;9522.809543809224;11726.70683232926;11793.410329483491;11897.560999994981;11906;11921.821172682417;5678.4037676044245;5825.533957283492;5825.88348233033;5827;5900.085486749561;4559.840405585788;4744.928826067612;4746.644001699818;4750.976245118753;5089.847304580869;3943.309920763912;3947.3092208863336;3951.9012024699036;4020.6582440492884;4118.402831589463;1636.5680029973773;1657.395050806471;1658.6268089679968;1692.5275010740488;1707.63285893531;753.2655660730853;768.8500742355187;795.1690483444814;832.1719888710771;896.3635818568758;14508.202048887413;15149.261553358332;15178.772318415233;15194.848051519564;15250.542483725507;734.2143906020507;758.2228216078564;770.6840195519922;799.3046049936477;836.7615229659518;5654;8474.110218426977;8566.742997710078;8623.353248506388;8659.177378149066;352927;356405;370525;390288;399386;64632.03051954225;66158.66920665366;66215.66892165509;66278;69230.3076969234;865.5931712095431;869.4174902815002;888.4092078767676;891.6567121658209;894.7271082319955;13788.448462061406;13816.93091534536;14134.929325353307;14394.568162955127;14430.639234019234;30233.546496803006;30354.392912142077;31069.844650776602;31376.68623313829;31973.68026319707;39998.40002399908;41513.37729933993;43249.78375108104;43406.34890476709;43602;5773.566982476247;6679.732810687712;6963.442924565921;6985;7040.8943865843075;9034.322425817958;10472.787520086307;10473.162147028068;10579.206559507913;10927.781444370909;8955.910440895508;9246.306527010636;9583.952080239833;9678.080582344666;9969.900300996896;9304.860427093463;9360.11078947499;9459.810803784023;9465.290103242147;9620.37467564606;9345;9348.813023739624;9464.574094165917;10005.948780500126;10079.596816127272;6937.7571784987285;6960.060391847238;7053.224145344111;7074.68163932614;7104.822379440556;8547.871781923152;9673.516324183904;9696.321257512189;9772.511374431393;9787.217022638315 13:07:44 INFO - PROCESS | 6304 | |3;mootools.html;1201.3032441184114;1219.8536175658921;1237.127824883457;1264.9304288264148;1590.5705459525927;5959.3146788119375;6684.699188536515;6798.762043328491;6810.387065164135;6816.625085620289;6648.468122550196;6649.368310010541;6695.732170713166;6705.362990515905;6719.563228390151;1690.323870451817;1966.4690533555931;1968.8326492248177;1989.1148438944676;1991.1836147179658;2011.5071807407205;2021.6563184258637;2022.2416593777334;2022.5348169920926;2023.4233243525598;1948.6882098864185;1964.8428125749906;1976.2095161935197;1993;1994.3917105282883;1885.3966730646198;1892.8391086757642;1896.1846406045395;1900.5058684742066;1900.809919008102;1969.7045443183495;2002.2591641092743;2009.65835807913;2010.58782949495;2012.0543344628147;7023.92976070243;7074.717011319541;7076.540024898417;7080.822979425504;7089.7873063808165;3876.6317199865966;3955.2880481513316;3984.5816189299994;3987.322155233617;3996.360582306817;2459.274514018351;2546.1979476464853;2595;2595.4160313929406;2599.7400259974042;829.5561874397229;830.0744669693308;840.2396978330388;844.1431946574232;871.808202195516;9435.858462123073;9452.338336316392;9454;9462.053794620551;9475;3560;3632.9818350908604;3664.5052917856283;3682.9503591476837;3758.755680880734;8064.354851611857;8083.514989100673;8084.272415482517;8084.353251739847;8096.392770542233;3967.484227050465;3980.1442689821247;3988.2422339755935;4006.6994975376965;4007.0182805212326;2895.2472357187285;3364.7644664873224;3422.161570415264;3440.122768694017;3444.121748954001;3156.6527681954967;3199.7920135191603;3243.2216268095485;3250.9187270317957;3253.186703324169;1010.2221289606962;1027.9280450368403;1036.284948410382;1042.166266986408;1050.207093644309;915.697819719491;927.1840780113591;963.1620490173594;964.0744884910424;967.3277072434731;6499.5775274607;6508.316626754217;6553.868922621521;6619.172603424572;6630.303818099127;420.4891057365316;428.2569741498498;428.3596023944223;428.52005753556216;430.72433642468843;4866.343043689128;4868;4891.584215341664;4906.558409743069;4913.803447862046;7775.416843736629;7967.8406431871035;8007.119216886138;8176.059753128347;8235.29999949999;7969.402294827911;8031.076426210943;8038.663954458951;8055.7583272501915;8057.758267251992;6412.39082287182;6491.221053473613;6529.053287273414;6538;6579.835504112435;6334.271558770801;6422.100905873275;6434.324395938546;6441.066045423294;6457.547971642128;7210.675519601526;7267.273272672691;7401.33387995083;7423.777286681408;7525.887111693439;7484.176740558643;7626.3898888089925;7675.155732869268;7703.114141873756;7774.611269436618;5092.898142037065;5692.373838877637;6115.755369785336;6176.845578860564;6213.565050446426;6048.7278072487725;6378.362163783585;6383.425491705769;6391.041343798467;6405.8718825624155;5694.032014557452;5733.3406658234835;5772.855678607901;5836.708164591839;5846.766129354778;5636;5712;5763.4812866842185;5863.824085277449;5892.440218179266;5996.970015149896;6076.301225358963;6120.051392034242;6150.876982460236;6239.251289845248;5656.095024796013;5657.8019769307875;5710.400407957105;5714.3999880012;5722.62802917809;5912.556558258234;5941.197938278277;5955.91066134017;5965.582409231312;5969.134475501115 13:07:44 INFO - PROCESS | 6304 | |4;prototype.html;270.98509581972985;276.0572644419307;277.97498225159734;280.2950579293078;281.853436213169;5092.974535127329;5198.844034678966;5237.554807841333;5256;5266.81566145185;5264.447233040533;5277.208418737182;5285.682859028461;5287.41838397776;5303.071962406573;3839.5968423315567;3951.0517475805887;4048.7368321059184;4085.673146148301;4109.260333140033;4086.16233672098;4095.5494895561615;4096.733712308705;4097.405876147956;4098.385242213662;4041.1513582147786;4051.817668204923;4056.5943405659345;4060.167665628539;4062.309407400734;4049.1699201663587;4057.9594204057876;4058.6550143237564;4059.573744756817;4060.614241647039;3550.7692000020174;3551.964480355189;3552.0409489437707;3552.928941421183;3553.7690050146657;5082.059818933509;5105.923411148836;5109.565686916617;5110.386753589556;5117;4310.181065597558;4624.653151013687;4626.86119416418;4628.051249493846;4631.374764406795;5352.705601191933;5356.330458692663;5373.408925018245;5376.247325374451;5380.704061276629;3578.159132603836;3608.6932610728118;3609.8375573099274;3617.330793803155;3633.909152271188;5595.356533998602;5696.231008813798;5791.131330300446;5815.185873977646;5821.417858214229;3794.051487128218;3819.2743378757946;3827.770333779926;3833.0800607853917;3834.1564855731694;3879.18537107205;3884.747491413049;3888.4361767543546;3888.9805550972064;3895.1235971906094;4510.72935623857;4520.52534483881;4523.525029871882;4524.8416305429155;4532.229520981441;5200.92198617021;5304.681719096867;5437.483439073281;5507.228987941691;5508.20131080991;1350.8108864758942;1369.630199846036;1370.5545697648106;1371.4856928651755;1373.368250604733;848.6138806842872;865.1521508921293;870.2646263906988;875.0767939823547;903.8011637439753;4813.78337974792;4828.758562071953;4836.081144582518;4836.250381190921;4842.249451335048;5706.4864162225595;5710.2576665033275;5711.7429715662065;5714.514266287412;5720.970225359392;4824.855254342376;4831.371921650233;4836.371271734652;4841.685290456109;4841.830535931296;3041.9543706844415;3069.0332545248175;3070.1250143708935;3076.1694342527394;3080.2607374230024;5410.59420543453;5411.540019098342;5416.160495123262;5418.566514678816;5424.376196737426;5683.914741278884;5859.150423188614;5860.794872179454;5943.55423343251;5951.761929522857;5438.374586922555;5459.099248623933;5460.372057213392;5461.590380721462;5464.071107911585;5750.0512415450985;5766.509846663081;5771.3651498335985;5773.566982476415;5774.48029677331;5632.183333416713;5692.857678558069;5694.943050569441;5701.771929122954;5704.629199102045;5437.429069947757;5447.945520544744;5452.628106773566;5455.18172274162;5455.618106732491;3718.665320121202;3804.144067584771;3868.922621547497;3874.5544262409057;3877.360235561101;5488.1493368527945;5641.26663533738;5717.542596592346;5730.455606717355;5736.340320862987;5542.916856247079;5552.833414997556;5555.972220138873;5563;5572.4706152915405;5540.584456165723;5547.528460080777;5555.500004999408;5563.248961390161;5564;5439.864003399946;5443.237946687546;5449.782008719607;5451.400345961862;5456.59075569326;5583.050881350099;5590.608657393944;5593.692346920959;5593.944060559343;5594.832155035193;5277.947220527899;5454.481824226692;5454.536364409069;5466.480684334982;5469.535089517435 13:07:44 INFO - PROCESS | 6304 | |5;yui.html;570.9229254050701;587.5123647372678;591.1841658511254;650.6941737383431;662.1755913887209;11073.280236784614;11158.665240042792;11210.159238057158;11217.831732524019;11261.943690281547;10460.267781255316;10494.527746251419;10516.526756295965;10594.364338139718;10703.732406689836;574.0241589298189;672.4889084295921;681.8943063825103;694.7221111555368;696.9303069693041;687.2303020616916;689.3106893106893;693.2235895796715;694.472201127142;694.6249025526209;719.3777382564097;723.4501778648239;723.5297056913022;724.1563578431121;724.2829598697278;598.9880202395949;706.4313227851577;714.478430745556;727.9927200727977;728.7740800351908;523.6622378565804;524.4178961352895;527.014482916944;527.9683219006872;528.1918664443369;9528.857067143997;9542.284328675378;9553.140217380469;9560.95219523905;9577.281703872237;9645.131938125602;10683.78632427355;10800.837987430195;11422.657320280405;11605.477753501113;8742;8795.120487951217;8813.338999575057;8843.292536597057;8844.46933184011;3144.9528257076163;3197.2486465680545;3231.482962725976;3232.127325622069;3303.9834800826084;41210.9999999997;41450;41580.58419415797;41615;41694.166116677494;8318.625661845232;8352.290055345242;8388.37087218461;8433.325333973267;8555.871661925075;15807.36770529166;15811.288492017888;15815.604609884615;15821.841781582038;15860.20698965047;5889.38161493037;5899.528037756969;6019.398060193946;6035.758569657252;6093.390660933871;3444.5522082129664;3502.772319799205;3604.4773507841214;3606.332828426697;3689.7970611616083;2527.2039307618043;2528.05198050731;2540.2506260653154;2546.1597672767944;2550.8214424990074;373.7421179386215;428.18430889156207;436.6201404777864;456.4271838842298;456.90115272769043;477.7682823830439;479.99520004799507;485.579973323073;487.7390596031106;495.4154098164201;6848.2466928638805;6852.109225800714;6976.965115174493;7161.283871612797;7204.9279507204255;468.5789575356522;481.4944308476156;484.4562028759612;484.9830255941025;508.20719677303526;3270.3622793555505;3273.885414010498;3329.8168600727195;3345.983270083634;3379.898603041913;49210.753946230754;50878.491215088114;51457;51569.2264616031;51615.74192129015;44857.55142448534;44992.3251151233;45286;47083.5291647086;47722.5227747725;41039;41503.7924810374;42217;42251.7887410561;42393.576064239576;6767.661616919036;7003.474739394667;7123.786286411416;7192.172900116553;7207.315305046012;29981.250468738457;30437.847810760806;31204;31802.36395272128;32103.839480802446;35498.46752298666;39733.60266397299;39909.2018159641;40251.1949761009;41434.37848432216;9072.818543629222;9080.364374493722;9252.352335336462;9277.67528136512;9297.395669281475;10001.449920254165;10154.136898363426;10283.537240824031;10577.153827693612;10592.629257975934;9493.715188544355;10215.897841021495;10246.948765256126;10442.425666588411;10774.838377424188;9849.753756155867;10023.148032417326;10132.088112069949;10150.746231344276;10351.741206469898;9874.160696340892;10019.148372388428;10470.267081304235;10522.421266830397;10982.560697572007;8321.375896807642;8449.493030418194;8532.573371331533;8556.10160933093;8647.740567782977;8144.226298501633;8559.443636163629;8606.225439710455;8673.913260867563;8989.370744048116 13:07:44 INFO - PROCESS | 6304 | __end_tp_report 13:07:44 INFO - PROCESS | 6304 | __start_cc_report 13:07:44 INFO - PROCESS | 6304 | _x_x_mozilla_cycle_collect,965 13:07:44 INFO - PROCESS | 6304 | __end_cc_report 13:07:44 INFO - PROCESS | 6304 | __startTimestamp1456866464885__endTimestamp 13:07:44 INFO - PROCESS | 6304 | 13:07:44 INFO - PROCESS | 6304 | ------- Summary: start ------- 13:07:44 INFO - PROCESS | 6304 | Number of tests: 6 13:07:44 INFO - PROCESS | 6304 | 13:07:44 INFO - PROCESS | 6304 | [#0] dojo.html Cycles:165 Average:4447.81 Median:4574.59 stddev:449.35 (9.8%) stddev-sans-first:425.82 13:07:44 INFO - PROCESS | 6304 | Values: 2566.8 2645.0 2645.2 2656.7 2676.2 4383.2 4456.4 4492.2 4496.7 4521.0 4478.5 4497.5 4507.4 4508.6 4602.8 4103.3 4123.0 4128.5 4206.5 4248.9 4173.0 4183.3 4198.0 4212.8 4302.8 4020.6 4123.2 4195.8 4202.2 4230.2 4126.2 4165.2 4174.1 4195.8 4206.1 3954.2 4114.4 4135.9 4142.3 4193.8 4372.4 4440.1 4509.5 4529.1 4530.7 4789.4 4805.1 4814.8 4816.9 4859.6 4840.6 4842.6 4847.9 4849.4 4892.2 4362.3 4469.8 4530.6 4560.1 4569.5 4863.4 4900.7 4907.2 4912.9 4960.2 4561.0 4717.2 4724.7 4727.6 4728.4 4777.5 4817.1 4819.4 4856.0 4862.7 4748.5 4756.0 4762.7 4768.5 4805.5 4564.9 4638.5 4732.6 4742.9 4794.0 4033.8 4067.7 4084.7 4098.5 4108.5 3517.8 3541.1 3542.3 3550.6 3582.6 4029.8 4110.8 4129.8 4146.8 4163.8 4807.3 4809.9 4811.4 4819.0 4870.4 4096.6 4132.5 4145.6 4174.2 4190.9 4149.9 4246.4 4277.0 4320.4 4335.6 4577.0 4578.6 4582.1 4590.6 4596.2 4779.8 4807.3 4813.2 4824.3 4861.7 4453.7 4559.3 4561.3 4615.5 4656.5 4752.8 4757.4 4776.8 4793.0 4833.4 4831.1 4839.0 4852.2 4860.1 4881.5 4542.4 4630.3 4680.5 4705.8 4715.3 4649.6 4655.9 4657.0 4676.9 4718.7 4590.1 4599.6 4602.1 4604.9 4634.7 4530.5 4674.7 4729.7 4760.6 4784.7 4565.6 4574.6 4590.1 4595.3 4612.1 13:07:44 INFO - PROCESS | 6304 | 13:07:44 INFO - PROCESS | 6304 | [#1] ext.html Cycles:180 Average:39059.30 Median:178830.09 stddev:66124.55 (37.0%) stddev-sans-first:66246.62 13:07:44 INFO - PROCESS | 6304 | Values: 487.3 500.8 515.0 520.9 545.5 24523.6 31912.0 32441.4 32507.2 32543.2 34751.0 35121.1 35145.8 35167.6 35211.5 7497.2 7600.1 7699.5 7702.0 7702.2 7441.5 7596.1 7596.9 7602.4 7770.9 7739.4 7799.2 7814.5 7838.9 7849.4 7727.7 7761.2 7795.3 7801.8 7807.7 7682.8 7801.1 7803.3 7807.2 7809.2 35673.6 36066.3 36118.6 36119.5 36132.8 2735.5 3149.1 3168.2 3216.1 3302.9 27120.0 27374.6 27519.6 27647.3 28004.6 3237.3 3397.7 3402.5 3441.6 3446.6 241590.0 242126.0 242422.0 242592.0 242654.0 50332.0 52216.7 52450.7 52463.2 52499.2 56538.7 56767.7 57090.1 57185.0 57318.7 10403.8 10481.2 10541.6 10607.5 10617.5 8109.4 8112.1 8167.8 8226.2 8426.9 17613.5 17688.6 17688.8 17709.0 17718.0 7087.4 7246.7 7249.5 7294.5 7338.6 716.0 728.7 821.8 914.4 938.7 23554.5 23606.3 23629.0 24657.0 24829.3 841.7 843.5 891.8 1006.4 1028.2 12768.7 12792.0 12973.2 12998.7 13036.7 318524.4 323518.0 324096.0 324109.0 325117.0 45662.8 46217.8 46238.3 46245.5 46277.8 1001.4 1076.8 1104.5 1112.5 1203.8 23889.4 24779.4 25057.4 25068.5 25081.1 33738.8 34356.7 34417.0 34422.8 34475.7 161978.0 163077.0 163086.0 163223.0 163230.0 24225.5 29105.9 29134.9 29179.9 29345.9 34492.1 34826.3 34933.3 35178.3 35218.6 30057.2 30527.7 30728.0 30905.5 30982.4 30360.8 30507.8 31008.4 31047.7 31203.0 30252.0 30450.0 30850.8 30885.5 30959.2 27132.5 27321.9 27805.9 27916.7 28200.9 21451.4 22283.7 22382.9 22511.7 22546.2 13:07:44 INFO - PROCESS | 6304 | 13:07:44 INFO - PROCESS | 6304 | [#2] jquery.html Cycles:180 Average:21901.04 Median:4760.96 stddev:61408.22 (1289.8%) stddev-sans-first:61559.08 13:07:44 INFO - PROCESS | 6304 | Values: 304.9 314.5 314.8 316.5 319.6 11675.0 13961.4 14740.9 15299.5 15329.9 10216.8 10576.7 10597.3 10598.0 13716.0 4682.5 4824.9 4839.6 4851.6 4852.3 4647.3 4755.8 4788.8 4868.3 4870.5 3407.6 4726.8 5357.1 5540.3 5551.1 5511.4 5522.4 5523.3 5537.8 5550.6 4711.1 4766.1 4823.9 4833.7 4837.3 17603.4 18143.1 18160.3 18250.6 18306.5 1822.5 1836.8 1872.2 1894.6 1911.6 11257.6 11736.2 11995.9 12211.8 12282.9 1711.8 1717.3 1718.7 1788.0 1793.1 49114.5 50920.7 50931.0 51865.7 54756.5 8717.1 9074.5 9340.0 9506.4 9522.8 11726.7 11793.4 11897.6 11906.0 11921.8 5678.4 5825.5 5825.9 5827.0 5900.1 4559.8 4744.9 4746.6 4751.0 5089.8 3943.3 3947.3 3951.9 4020.7 4118.4 1636.6 1657.4 1658.6 1692.5 1707.6 753.3 768.9 795.2 832.2 896.4 14508.2 15149.3 15178.8 15194.8 15250.5 734.2 758.2 770.7 799.3 836.8 5654.0 8474.1 8566.7 8623.4 8659.2 352927.0 356405.0 370525.0 390288.0 399386.0 64632.0 66158.7 66215.7 66278.0 69230.3 865.6 869.4 888.4 891.7 894.7 13788.4 13816.9 14134.9 14394.6 14430.6 30233.5 30354.4 31069.8 31376.7 31973.7 39998.4 41513.4 43249.8 43406.3 43602.0 5773.6 6679.7 6963.4 6985.0 7040.9 9034.3 10472.8 10473.2 10579.2 10927.8 8955.9 9246.3 9584.0 9678.1 9969.9 9304.9 9360.1 9459.8 9465.3 9620.4 9345.0 9348.8 9464.6 10005.9 10079.6 6937.8 6960.1 7053.2 7074.7 7104.8 8547.9 9673.5 9696.3 9772.5 9787.2 13:07:44 INFO - PROCESS | 6304 | 13:07:44 INFO - PROCESS | 6304 | [#3] mootools.html Cycles:180 Average:4720.11 Median:5878.13 stddev:2517.15 (42.8%) stddev-sans-first:2510.31 13:07:44 INFO - PROCESS | 6304 | Values: 1201.3 1219.9 1237.1 1264.9 1590.6 5959.3 6684.7 6798.8 6810.4 6816.6 6648.5 6649.4 6695.7 6705.4 6719.6 1690.3 1966.5 1968.8 1989.1 1991.2 2011.5 2021.7 2022.2 2022.5 2023.4 1948.7 1964.8 1976.2 1993.0 1994.4 1885.4 1892.8 1896.2 1900.5 1900.8 1969.7 2002.3 2009.7 2010.6 2012.1 7023.9 7074.7 7076.5 7080.8 7089.8 3876.6 3955.3 3984.6 3987.3 3996.4 2459.3 2546.2 2595.0 2595.4 2599.7 829.6 830.1 840.2 844.1 871.8 9435.9 9452.3 9454.0 9462.1 9475.0 3560.0 3633.0 3664.5 3683.0 3758.8 8064.4 8083.5 8084.3 8084.4 8096.4 3967.5 3980.1 3988.2 4006.7 4007.0 2895.2 3364.8 3422.2 3440.1 3444.1 3156.7 3199.8 3243.2 3250.9 3253.2 1010.2 1027.9 1036.3 1042.2 1050.2 915.7 927.2 963.2 964.1 967.3 6499.6 6508.3 6553.9 6619.2 6630.3 420.5 428.3 428.4 428.5 430.7 4866.3 4868.0 4891.6 4906.6 4913.8 7775.4 7967.8 8007.1 8176.1 8235.3 7969.4 8031.1 8038.7 8055.8 8057.8 6412.4 6491.2 6529.1 6538.0 6579.8 6334.3 6422.1 6434.3 6441.1 6457.5 7210.7 7267.3 7401.3 7423.8 7525.9 7484.2 7626.4 7675.2 7703.1 7774.6 5092.9 5692.4 6115.8 6176.8 6213.6 6048.7 6378.4 6383.4 6391.0 6405.9 5694.0 5733.3 5772.9 5836.7 5846.8 5636.0 5712.0 5763.5 5863.8 5892.4 5997.0 6076.3 6120.1 6150.9 6239.3 5656.1 5657.8 5710.4 5714.4 5722.6 5912.6 5941.2 5955.9 5965.6 5969.1 13:07:44 INFO - PROCESS | 6304 | 13:07:44 INFO - PROCESS | 6304 | [#4] prototype.html Cycles:180 Average:4553.87 Median:5265.63 stddev:1367.34 (26.0%) stddev-sans-first:1332.86 13:07:44 INFO - PROCESS | 6304 | Values: 271.0 276.1 278.0 280.3 281.9 5093.0 5198.8 5237.6 5256.0 5266.8 5264.4 5277.2 5285.7 5287.4 5303.1 3839.6 3951.1 4048.7 4085.7 4109.3 4086.2 4095.5 4096.7 4097.4 4098.4 4041.2 4051.8 4056.6 4060.2 4062.3 4049.2 4058.0 4058.7 4059.6 4060.6 3550.8 3552.0 3552.0 3552.9 3553.8 5082.1 5105.9 5109.6 5110.4 5117.0 4310.2 4624.7 4626.9 4628.1 4631.4 5352.7 5356.3 5373.4 5376.2 5380.7 3578.2 3608.7 3609.8 3617.3 3633.9 5595.4 5696.2 5791.1 5815.2 5821.4 3794.1 3819.3 3827.8 3833.1 3834.2 3879.2 3884.7 3888.4 3889.0 3895.1 4510.7 4520.5 4523.5 4524.8 4532.2 5200.9 5304.7 5437.5 5507.2 5508.2 1350.8 1369.6 1370.6 1371.5 1373.4 848.6 865.2 870.3 875.1 903.8 4813.8 4828.8 4836.1 4836.3 4842.2 5706.5 5710.3 5711.7 5714.5 5721.0 4824.9 4831.4 4836.4 4841.7 4841.8 3042.0 3069.0 3070.1 3076.2 3080.3 5410.6 5411.5 5416.2 5418.6 5424.4 5683.9 5859.2 5860.8 5943.6 5951.8 5438.4 5459.1 5460.4 5461.6 5464.1 5750.1 5766.5 5771.4 5773.6 5774.5 5632.2 5692.9 5694.9 5701.8 5704.6 5437.4 5447.9 5452.6 5455.2 5455.6 3718.7 3804.1 3868.9 3874.6 3877.4 5488.1 5641.3 5717.5 5730.5 5736.3 5542.9 5552.8 5556.0 5563.0 5572.5 5540.6 5547.5 5555.5 5563.2 5564.0 5439.9 5443.2 5449.8 5451.4 5456.6 5583.1 5590.6 5593.7 5593.9 5594.8 5277.9 5454.5 5454.5 5466.5 5469.5 13:07:44 INFO - PROCESS | 6304 | 13:07:44 INFO - PROCESS | 6304 | [#5] yui.html Cycles:180 Average:11980.64 Median:484.72 stddev:14201.08 (2929.8%) stddev-sans-first:14215.07 13:07:44 INFO - PROCESS | 6304 | Values: 570.9 587.5 591.2 650.7 662.2 11073.3 11158.7 11210.2 11217.8 11261.9 10460.3 10494.5 10516.5 10594.4 10703.7 574.0 672.5 681.9 694.7 696.9 687.2 689.3 693.2 694.5 694.6 719.4 723.5 723.5 724.2 724.3 599.0 706.4 714.5 728.0 728.8 523.7 524.4 527.0 528.0 528.2 9528.9 9542.3 9553.1 9561.0 9577.3 9645.1 10683.8 10800.8 11422.7 11605.5 8742.0 8795.1 8813.3 8843.3 8844.5 3145.0 3197.2 3231.5 3232.1 3304.0 41211.0 41450.0 41580.6 41615.0 41694.2 8318.6 8352.3 8388.4 8433.3 8555.9 15807.4 15811.3 15815.6 15821.8 15860.2 5889.4 5899.5 6019.4 6035.8 6093.4 3444.6 3502.8 3604.5 3606.3 3689.8 2527.2 2528.1 2540.3 2546.2 2550.8 373.7 428.2 436.6 456.4 456.9 477.8 480.0 485.6 487.7 495.4 6848.2 6852.1 6977.0 7161.3 7204.9 468.6 481.5 484.5 485.0 508.2 3270.4 3273.9 3329.8 3346.0 3379.9 49210.8 50878.5 51457.0 51569.2 51615.7 44857.6 44992.3 45286.0 47083.5 47722.5 41039.0 41503.8 42217.0 42251.8 42393.6 6767.7 7003.5 7123.8 7192.2 7207.3 29981.3 30437.8 31204.0 31802.4 32103.8 35498.5 39733.6 39909.2 40251.2 41434.4 9072.8 9080.4 9252.4 9277.7 9297.4 10001.4 10154.1 10283.5 10577.2 10592.6 9493.7 10215.9 10246.9 10442.4 10774.8 9849.8 10023.1 10132.1 10150.7 10351.7 9874.2 10019.1 10470.3 10522.4 10982.6 8321.4 8449.5 8532.6 8556.1 8647.7 8144.2 8559.4 8606.2 8673.9 8989.4 13:07:44 INFO - PROCESS | 6304 | -------- Summary: end -------- 13:07:44 INFO - PROCESS | 6304 | 13:07:45 INFO - PROCESS | 6304 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:07:45 INFO - PROCESS | 6304 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:07:45 INFO - PROCESS | 6304 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:07:45 INFO - PROCESS | 6304 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:07:45 INFO - PROCESS | 6304 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:07:45 INFO - TEST-INFO | 6304: exit 0 13:07:45 INFO - TEST-OK | dromaeo_css | took 1115970ms 13:07:45 INFO - TEST-START | kraken 13:07:45 INFO - operating with platform_type : linux_ 13:07:45 INFO - Initialising browser for kraken test... 13:07:45 INFO - TEST-INFO | started process 6479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeV2Tre/profile http://localhost:46476/getInfo.html) 13:07:49 INFO - PROCESS | 6479 | __metrics Screen width/height:1600/1200 13:07:49 INFO - PROCESS | 6479 | colorDepth:24 13:07:49 INFO - PROCESS | 6479 | Browser inner width/height: 1024/697 13:07:49 INFO - PROCESS | 6479 | __metrics 13:07:50 INFO - PROCESS | 6479 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:07:50 INFO - PROCESS | 6479 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:07:50 INFO - PROCESS | 6479 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:07:50 INFO - PROCESS | 6479 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:07:50 INFO - PROCESS | 6479 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:07:50 INFO - PROCESS | 6479 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:07:50 INFO - PROCESS | 6479 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:07:50 INFO - PROCESS | 6479 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 13:07:51 INFO - TEST-INFO | 6479: exit 0 13:07:51 INFO - Browser initialized. 13:07:51 INFO - Running cycle 1/1 for kraken test... 13:07:51 INFO - TEST-INFO | started process 6563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeV2Tre/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:08:03 INFO - PROCESS | 6563 | RSS: Main: 152858624 13:08:03 INFO - PROCESS | 6563 | 13:08:05 INFO - PROCESS | 6563 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46476/tests/kraken/driver.html?testName=audio-beat-detection) 13:08:06 INFO - PROCESS | 6563 | RSS: Main: 196775936 13:08:06 INFO - PROCESS | 6563 | 13:08:09 INFO - PROCESS | 6563 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46476/tests/kraken/driver.html?testName=audio-dft) 13:08:09 INFO - PROCESS | 6563 | RSS: Main: 185729024 13:08:09 INFO - PROCESS | 6563 | 13:08:12 INFO - PROCESS | 6563 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46476/tests/kraken/driver.html?testName=audio-fft) 13:08:13 INFO - PROCESS | 6563 | RSS: Main: 172003328 13:08:13 INFO - PROCESS | 6563 | 13:08:15 INFO - PROCESS | 6563 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46476/tests/kraken/driver.html?testName=audio-oscillator) 13:08:15 INFO - PROCESS | 6563 | RSS: Main: 172679168 13:08:15 INFO - PROCESS | 6563 | 13:08:18 INFO - PROCESS | 6563 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46476/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:08:18 INFO - PROCESS | 6563 | RSS: Main: 175386624 13:08:18 INFO - PROCESS | 6563 | 13:08:21 INFO - PROCESS | 6563 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46476/tests/kraken/driver.html?testName=imaging-darkroom) 13:08:22 INFO - PROCESS | 6563 | RSS: Main: 175247360 13:08:22 INFO - PROCESS | 6563 | 13:08:25 INFO - PROCESS | 6563 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46476/tests/kraken/driver.html?testName=imaging-desaturate) 13:08:26 INFO - PROCESS | 6563 | RSS: Main: 176889856 13:08:26 INFO - PROCESS | 6563 | 13:08:29 INFO - PROCESS | 6563 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46476/tests/kraken/driver.html?testName=json-parse-financial) 13:08:29 INFO - PROCESS | 6563 | RSS: Main: 176939008 13:08:29 INFO - PROCESS | 6563 | 13:08:31 INFO - PROCESS | 6563 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46476/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:08:32 INFO - PROCESS | 6563 | RSS: Main: 185565184 13:08:32 INFO - PROCESS | 6563 | 13:08:34 INFO - PROCESS | 6563 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:08:34 INFO - PROCESS | 6563 | RSS: Main: 182980608 13:08:34 INFO - PROCESS | 6563 | 13:08:36 INFO - PROCESS | 6563 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:08:37 INFO - PROCESS | 6563 | RSS: Main: 193048576 13:08:37 INFO - PROCESS | 6563 | 13:08:39 INFO - PROCESS | 6563 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:08:40 INFO - PROCESS | 6563 | RSS: Main: 199225344 13:08:40 INFO - PROCESS | 6563 | 13:08:43 INFO - PROCESS | 6563 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:08:43 INFO - PROCESS | 6563 | RSS: Main: 197595136 13:08:43 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | Cycle 1(1): loaded http://localhost:46476/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46476/tests/kraken/driver.html?testName=ai-astar) 13:08:45 INFO - PROCESS | 6563 | RSS: Main: 258060288 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | __start_tp_report 13:08:45 INFO - PROCESS | 6563 | _x_x_mozilla_page_load 13:08:45 INFO - PROCESS | 6563 | _x_x_mozilla_page_load_details 13:08:45 INFO - PROCESS | 6563 | |i|pagename|runs| 13:08:45 INFO - PROCESS | 6563 | |0;ai-astar;113;113;108;114;114;115;104;115;114;115 13:08:45 INFO - PROCESS | 6563 | |1;audio-beat-detection;155;151;158;176;136;159;162;134;180;132 13:08:45 INFO - PROCESS | 6563 | |2;audio-dft;161;162;161;162;162;162;161;162;161;162 13:08:45 INFO - PROCESS | 6563 | |3;audio-fft;73;73;100;98;73;74;73;110;97;73 13:08:45 INFO - PROCESS | 6563 | |4;audio-oscillator;96;95;145;95;96;95;146;94;95;139 13:08:45 INFO - PROCESS | 6563 | |5;imaging-gaussian-blur;117;116;117;118;117;117;116;117;117;117 13:08:45 INFO - PROCESS | 6563 | |6;imaging-darkroom;147;147;146;148;147;147;146;147;147;147 13:08:45 INFO - PROCESS | 6563 | |7;imaging-desaturate;96;95;96;96;96;96;96;96;97;95 13:08:45 INFO - PROCESS | 6563 | |8;json-parse-financial;68;67;69;66;66;76;67;77;66;65 13:08:45 INFO - PROCESS | 6563 | |9;json-stringify-tinderbox;71;71;71;71;72;71;71;71;72;71 13:08:45 INFO - PROCESS | 6563 | |10;stanford-crypto-aes;82;83;99;84;83;85;83;84;84;83 13:08:45 INFO - PROCESS | 6563 | |11;stanford-crypto-ccm;119;119;119;121;129;139;138;128;124;123 13:08:45 INFO - PROCESS | 6563 | |12;stanford-crypto-pbkdf2;153;140;153;162;151;149;147;155;140;139 13:08:45 INFO - PROCESS | 6563 | |13;stanford-crypto-sha256-iterative;71;72;71;72;70;69;70;71;70;71 13:08:45 INFO - PROCESS | 6563 | __end_tp_report 13:08:45 INFO - PROCESS | 6563 | __start_cc_report 13:08:45 INFO - PROCESS | 6563 | _x_x_mozilla_cycle_collect,1185 13:08:45 INFO - PROCESS | 6563 | __end_cc_report 13:08:45 INFO - PROCESS | 6563 | __startTimestamp1456866525881__endTimestamp 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | ------- Summary: start ------- 13:08:45 INFO - PROCESS | 6563 | Number of tests: 14 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:3.63 (3.2%) stddev-sans-first:3.84 13:08:45 INFO - PROCESS | 6563 | Values: 113.0 113.0 108.0 114.0 114.0 115.0 104.0 115.0 114.0 115.0 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | [#1] audio-beat-detection Cycles:10 Average:154.30 Median:158.50 stddev:16.61 (10.5%) stddev-sans-first:17.61 13:08:45 INFO - PROCESS | 6563 | Values: 155.0 151.0 158.0 176.0 136.0 159.0 162.0 134.0 180.0 132.0 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.52 (0.3%) stddev-sans-first:0.50 13:08:45 INFO - PROCESS | 6563 | Values: 161.0 162.0 161.0 162.0 162.0 162.0 161.0 162.0 161.0 162.0 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | [#3] audio-fft Cycles:10 Average:84.40 Median:73.00 stddev:14.91 (20.4%) stddev-sans-first:15.23 13:08:45 INFO - PROCESS | 6563 | Values: 73.0 73.0 100.0 98.0 73.0 74.0 73.0 110.0 97.0 73.0 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:95.00 stddev:23.35 (24.6%) stddev-sans-first:24.25 13:08:45 INFO - PROCESS | 6563 | Values: 96.0 95.0 145.0 95.0 96.0 95.0 146.0 94.0 95.0 139.0 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 13:08:45 INFO - PROCESS | 6563 | Values: 117.0 116.0 117.0 118.0 117.0 117.0 116.0 117.0 117.0 117.0 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 13:08:45 INFO - PROCESS | 6563 | Values: 147.0 147.0 146.0 148.0 147.0 147.0 146.0 147.0 147.0 147.0 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:08:45 INFO - PROCESS | 6563 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 95.0 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | [#8] json-parse-financial Cycles:10 Average:68.70 Median:67.50 stddev:4.27 (6.3%) stddev-sans-first:4.52 13:08:45 INFO - PROCESS | 6563 | Values: 68.0 67.0 69.0 66.0 66.0 76.0 67.0 77.0 66.0 65.0 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 13:08:45 INFO - PROCESS | 6563 | Values: 71.0 71.0 71.0 71.0 72.0 71.0 71.0 71.0 72.0 71.0 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.00 stddev:4.99 (5.9%) stddev-sans-first:5.17 13:08:45 INFO - PROCESS | 6563 | Values: 82.0 83.0 99.0 84.0 83.0 85.0 83.0 84.0 84.0 83.0 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:126.00 stddev:7.53 (6.0%) stddev-sans-first:7.57 13:08:45 INFO - PROCESS | 6563 | Values: 119.0 119.0 119.0 121.0 129.0 139.0 138.0 128.0 124.0 123.0 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.90 Median:152.00 stddev:7.50 (4.9%) stddev-sans-first:7.81 13:08:45 INFO - PROCESS | 6563 | Values: 153.0 140.0 153.0 162.0 151.0 149.0 147.0 155.0 140.0 139.0 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:0.95 (1.3%) stddev-sans-first:1.00 13:08:45 INFO - PROCESS | 6563 | Values: 71.0 72.0 71.0 72.0 70.0 69.0 70.0 71.0 70.0 71.0 13:08:45 INFO - PROCESS | 6563 | -------- Summary: end -------- 13:08:45 INFO - PROCESS | 6563 | 13:08:45 INFO - PROCESS | 6563 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:08:45 INFO - PROCESS | 6563 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:08:45 INFO - PROCESS | 6563 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:08:45 INFO - PROCESS | 6563 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:08:45 INFO - PROCESS | 6563 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:08:46 INFO - TEST-INFO | 6563: exit 0 13:08:46 INFO - TEST-OK | kraken | took 61159ms 13:08:46 INFO - SUITE-END | took 1177s 13:08:47 INFO - Completed test suite (00:19:37) 13:08:47 INFO - Working with test: dromaeo_css 13:08:47 INFO - Generating results file: dromaeo_css 13:08:47 INFO - Working with test: kraken 13:08:47 INFO - Generating results file: kraken 13:08:47 INFO - javascript benchmark 13:08:47 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:08:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 13:08:47 INFO - process_Request line: dromaeo_css 5891.99 graph.html#tests=[[72,132,35]] 13:08:47 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:08:47 INFO - process_Request line: kraken 1552.50 graph.html#tests=[[232,132,35]] 13:08:47 INFO - RETURN: dromaeo_css: 5891.99 13:08:47 INFO - RETURN: kraken: 1552.50 13:08:47 INFO - javascript benchmark 13:08:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2566.807489438292, 2644.973550264498, 2645.2328824640854, 2656.7210442903493, 2676.2238950704295, 4383.232934236504, 4456.376107344974, 4492.213862574049, 4496.685232033755, 4520.977395113028, 4478.529754375784, 4497.527759585246, 4507.4365704286965, 4508.594226519621, 4602.815887364502, 4103.322951712964, 4123.0, 4128.504579450462, 4206.47419072616, 4248.872533823975, 4172.97913510432, 4183.267928112583, 4198.0344520760245, 4212.831486740527, 4302.806373713191, 4020.6381425671684, 4123.2165888481095, 4195.769232692201, 4202.222588821078, 4230.238557059728, 4126.216018956418, 4165.229432554987, 4174.102567947906, 4195.811188496525, 4206.116715489751, 3954.2486927483687, 4114.403411505345, 4135.90398544386, 4142.2958097123565, 4193.769342686151, 4372.3878656988045, 4440.067585806984, 4509.458864936229, 4529.071540334224, 4530.728156310599, 4789.425268967746, 4805.063012712522, 4814.759262036884, 4816.903661926777, 4859.635527335464, 4840.588549973257, 4842.588379987706, 4847.878803029953, 4849.393825771778, 4892.168331383637, 4362.345648152771, 4469.798859051318, 4530.569595888385, 4560.087982403533, 4569.54304569547, 4863.367762190893, 4900.705957642482, 4907.1903135982875, 4912.926306105412, 4960.206366981266, 4560.95439045612, 4717.150912835654, 4724.71651700899, 4727.621790256771, 4728.385309909759, 4777.522247775264, 4817.0606731686985, 4819.373481447389, 4856.028794241166, 4862.708237505761, 4748.501407352247, 4756.0, 4762.666613337033, 4768.499307572724, 4805.519448055236, 4564.863054108382, 4638.512956139624, 4732.574068333797, 4742.881427964328, 4793.969296601247, 4033.8184781684895, 4067.736043833925, 4084.6528045116497, 4098.549159592442, 4108.465899433055, 3517.8065206413894, 3541.0970202598173, 3542.2738338640515, 3550.591681956608, 3582.5880023797076, 4029.798510074543, 4110.815013324408, 4129.772862492592, 4146.79266036703, 4163.75017498951, 4807.278908163734, 4809.927851082237, 4811.446683631427, 4819.0, 4870.4155501340065, 4096.610821971908, 4132.504099508018, 4145.585441455831, 4174.248635245685, 4190.895227619334, 4149.8962525937095, 4246.44796176495, 4276.957230427718, 4320.373545835836, 4335.588119128678, 4577.0, 4578.565036321477, 4582.08358328329, 4590.563896429834, 4596.195665758546, 4779.761011949458, 4807.278908163804, 4813.229883218668, 4824.300476430828, 4861.708297502161, 4453.710508816916, 4559.293309537027, 4561.315802629632, 4615.492295847387, 4656.534346565317, 4752.809887604457, 4757.35775670294, 4776.761161941959, 4792.976035119802, 4833.3958255218095, 4831.057943700945, 4839.0, 4852.19938710123, 4860.149473842134, 4881.487443818348, 4542.386777784956, 4630.328602352707, 4680.508546602694, 4705.835295764632, 4715.269133284346, 4649.558291962258, 4655.930161047655, 4656.976715116538, 4676.859694209179, 4718.669693121586, 4590.127875703739, 4599.609033232213, 4602.102589994919, 4604.88487787808, 4634.745089020136, 4530.456345238593, 4674.672772905864, 4729.668923175483, 4760.595349395202, 4784.688995215439, 4565.634749220121, 4574.588287054181, 4590.081983603226, 4595.333676616805, 4612.146752850734], "unit": "score", "name": "dojo.html", "value": 4420.9025363604505}, {"lowerIsBetter": false, "replicates": [487.30802260789676, 500.77715416639586, 514.9819756308525, 520.8854052108537, 545.4845171313111, 24523.632145517833, 31912.0, 32441.351172976527, 32507.187320316974, 32543.1864203395, 34751.0, 35121.12197195071, 35145.82427087867, 35167.648323516754, 35211.4718279226, 7497.212792656761, 7600.087989441275, 7699.538027718327, 7701.9614901925415, 7702.191269916662, 7441.479096463249, 7596.12644545876, 7596.9240307596765, 7602.353799926986, 7770.912072309881, 7739.419543534257, 7799.220077992184, 7814.452988290822, 7838.882416763753, 7849.411294152933, 7727.690892364299, 7761.185075567097, 7795.259450352264, 7801.8049548761455, 7807.726729564438, 7682.769516914502, 7801.141874393869, 7803.3367163791145, 7807.219278072204, 7809.180036096242, 35673.64326356729, 36066.278674426365, 36118.63881361205, 36119.458208126896, 36132.81933590341, 2735.5076086304457, 3149.1497295730023, 3168.2237851726245, 3216.115394180552, 3302.93394132116, 27120.0, 27374.589381159298, 27519.587424377587, 27647.30881727953, 28004.579931301047, 3237.287796684749, 3397.6602339766073, 3402.4896265560114, 3441.587009558869, 3446.5691788526433, 241590.0, 242126.0, 242422.0, 242592.0, 242654.0, 50332.0, 52216.73891630518, 52450.737746311024, 52463.213051804254, 52499.21251181235, 56538.71730641321, 56767.71616141893, 57090.14364784532, 57185.0, 57318.71340643353, 10403.84394234087, 10481.161507079567, 10541.631042913461, 10607.522661480098, 10617.469126543641, 8109.391795615353, 8112.148224436467, 8167.754967350989, 8226.218509241613, 8426.915730842737, 17613.47159585189, 17688.55778605545, 17688.823111768717, 17709.0, 17718.0, 7087.433005359559, 7246.746363877344, 7249.492535522463, 7294.525855819355, 7338.559686418832, 715.9713611455587, 728.7158008376738, 821.757581513455, 914.3919293669768, 938.6761567259421, 23554.528909421715, 23606.29181124569, 23629.0, 24657.0, 24829.25512234636, 841.7264389073454, 843.4644001059371, 891.8038031633031, 1006.4414250091123, 1028.1723212813756, 12768.6807829805, 12792.0, 12973.156744811557, 12998.740025199442, 13036.674083147807, 318524.4073779616, 323518.0, 324096.0, 324109.0, 325117.0, 45662.77168614202, 46217.76891115523, 46238.30642540364, 46245.53754462479, 46277.76861115673, 1001.379144930148, 1076.8277075667856, 1104.5195340027115, 1112.527175950218, 1203.7592481503734, 23889.402764931016, 24779.380515487257, 25057.373565661004, 25068.498630026934, 25081.122160724288, 33738.83130584331, 34356.656433435346, 34417.0, 34422.82788586041, 34475.65524344725, 161978.0, 163077.0, 163086.0, 163223.0, 163230.0, 24225.51548969046, 29105.854470728358, 29134.854325728236, 29179.85410072936, 29345.85327073351, 34492.13769655779, 34826.303473930886, 34933.301333973686, 35178.29643407066, 35218.64781352256, 30057.248568785955, 30527.694723053373, 30728.0, 30905.536416953313, 30982.380352393277, 30360.84819575888, 30507.84746076344, 31008.379832402774, 31047.68952310448, 31203.0, 30252.0, 30450.0, 30850.845745771127, 30885.536716949715, 30959.226019348796, 27132.457350852477, 27321.86339068292, 27805.860970695016, 27916.720832792224, 28200.85899570489, 21451.356459306247, 22283.665745013514, 22382.88808556012, 22511.662325064808, 22546.21088261903], "unit": "score", "name": "ext.html", "value": 15725.572281852892}, {"lowerIsBetter": false, "replicates": [304.9481588130018, 314.49680511182095, 314.84415214468834, 316.4525371107983, 319.59890337626274, 11675.0, 13961.44154233832, 14740.926295368521, 15299.464518741846, 15329.92335038326, 10216.795664086714, 10576.682699519008, 10597.258191926569, 10598.046175844172, 13716.0, 4682.461516925563, 4824.927626085611, 4839.612830973514, 4851.611871050308, 4852.320675105488, 4647.32613771003, 4755.785989630458, 4788.832390866321, 4868.318435419044, 4870.464248932614, 3407.5910890693153, 4726.763661816913, 5357.142857142858, 5540.307461567304, 5551.1118221084635, 5511.366192887789, 5522.392536820947, 5523.337199536061, 5537.750801213955, 5550.639208451458, 4711.128441238382, 4766.142094423002, 4823.927641085386, 4833.661643684944, 4837.274408838667, 17603.383881564085, 18143.092845357678, 18160.27358905642, 18250.63498730018, 18306.450806475827, 1822.480593030993, 1836.7612210412694, 1872.17624245333, 1894.6210757848485, 1911.627232689626, 11257.605983790529, 11736.178467507278, 11995.880041199563, 12211.816822747665, 12282.938585307016, 1711.820258872813, 1717.3302412059306, 1718.6734520441075, 1787.9642407151914, 1793.0944872839132, 49114.50885491135, 50920.74539627278, 50931.0, 51865.74067129678, 54756.452435475534, 8717.084706105894, 9074.45553266806, 9339.953300233592, 9506.429614223169, 9522.809543809224, 11726.70683232926, 11793.410329483491, 11897.560999994981, 11906.0, 11921.821172682417, 5678.4037676044245, 5825.533957283492, 5825.88348233033, 5827.0, 5900.085486749561, 4559.840405585788, 4744.928826067612, 4746.644001699818, 4750.976245118753, 5089.847304580869, 3943.309920763912, 3947.3092208863336, 3951.9012024699036, 4020.6582440492884, 4118.402831589463, 1636.5680029973773, 1657.395050806471, 1658.6268089679968, 1692.5275010740488, 1707.63285893531, 753.2655660730853, 768.8500742355187, 795.1690483444814, 832.1719888710771, 896.3635818568758, 14508.202048887413, 15149.261553358332, 15178.772318415233, 15194.848051519564, 15250.542483725507, 734.2143906020507, 758.2228216078564, 770.6840195519922, 799.3046049936477, 836.7615229659518, 5654.0, 8474.110218426977, 8566.742997710078, 8623.353248506388, 8659.177378149066, 352927.0, 356405.0, 370525.0, 390288.0, 399386.0, 64632.03051954225, 66158.66920665366, 66215.66892165509, 66278.0, 69230.3076969234, 865.5931712095431, 869.4174902815002, 888.4092078767676, 891.6567121658209, 894.7271082319955, 13788.448462061406, 13816.93091534536, 14134.929325353307, 14394.568162955127, 14430.639234019234, 30233.546496803006, 30354.392912142077, 31069.844650776602, 31376.68623313829, 31973.68026319707, 39998.40002399908, 41513.37729933993, 43249.78375108104, 43406.34890476709, 43602.0, 5773.566982476247, 6679.732810687712, 6963.442924565921, 6985.0, 7040.8943865843075, 9034.322425817958, 10472.787520086307, 10473.162147028068, 10579.206559507913, 10927.781444370909, 8955.910440895508, 9246.306527010636, 9583.952080239833, 9678.080582344666, 9969.900300996896, 9304.860427093463, 9360.11078947499, 9459.810803784023, 9465.290103242147, 9620.37467564606, 9345.0, 9348.813023739624, 9464.574094165917, 10005.948780500126, 10079.596816127272, 6937.7571784987285, 6960.060391847238, 7053.224145344111, 7074.68163932614, 7104.822379440556, 8547.871781923152, 9673.516324183904, 9696.321257512189, 9772.511374431393, 9787.217022638315], "unit": "score", "name": "jquery.html", "value": 7323.662716414157}, {"lowerIsBetter": false, "replicates": [1201.3032441184114, 1219.8536175658921, 1237.127824883457, 1264.9304288264148, 1590.5705459525927, 5959.3146788119375, 6684.699188536515, 6798.762043328491, 6810.387065164135, 6816.625085620289, 6648.468122550196, 6649.368310010541, 6695.732170713166, 6705.362990515905, 6719.563228390151, 1690.323870451817, 1966.4690533555931, 1968.8326492248177, 1989.1148438944676, 1991.1836147179658, 2011.5071807407205, 2021.6563184258637, 2022.2416593777334, 2022.5348169920926, 2023.4233243525598, 1948.6882098864185, 1964.8428125749906, 1976.2095161935197, 1993.0, 1994.3917105282883, 1885.3966730646198, 1892.8391086757642, 1896.1846406045395, 1900.5058684742066, 1900.809919008102, 1969.7045443183495, 2002.2591641092743, 2009.65835807913, 2010.58782949495, 2012.0543344628147, 7023.92976070243, 7074.717011319541, 7076.540024898417, 7080.822979425504, 7089.7873063808165, 3876.6317199865966, 3955.2880481513316, 3984.5816189299994, 3987.322155233617, 3996.360582306817, 2459.274514018351, 2546.1979476464853, 2595.0, 2595.4160313929406, 2599.7400259974042, 829.5561874397229, 830.0744669693308, 840.2396978330388, 844.1431946574232, 871.808202195516, 9435.858462123073, 9452.338336316392, 9454.0, 9462.053794620551, 9475.0, 3560.0, 3632.9818350908604, 3664.5052917856283, 3682.9503591476837, 3758.755680880734, 8064.354851611857, 8083.514989100673, 8084.272415482517, 8084.353251739847, 8096.392770542233, 3967.484227050465, 3980.1442689821247, 3988.2422339755935, 4006.6994975376965, 4007.0182805212326, 2895.2472357187285, 3364.7644664873224, 3422.161570415264, 3440.122768694017, 3444.121748954001, 3156.6527681954967, 3199.7920135191603, 3243.2216268095485, 3250.9187270317957, 3253.186703324169, 1010.2221289606962, 1027.9280450368403, 1036.284948410382, 1042.166266986408, 1050.207093644309, 915.697819719491, 927.1840780113591, 963.1620490173594, 964.0744884910424, 967.3277072434731, 6499.5775274607, 6508.316626754217, 6553.868922621521, 6619.172603424572, 6630.303818099127, 420.4891057365316, 428.2569741498498, 428.3596023944223, 428.52005753556216, 430.72433642468843, 4866.343043689128, 4868.0, 4891.584215341664, 4906.558409743069, 4913.803447862046, 7775.416843736629, 7967.8406431871035, 8007.119216886138, 8176.059753128347, 8235.29999949999, 7969.402294827911, 8031.076426210943, 8038.663954458951, 8055.7583272501915, 8057.758267251992, 6412.39082287182, 6491.221053473613, 6529.053287273414, 6538.0, 6579.835504112435, 6334.271558770801, 6422.100905873275, 6434.324395938546, 6441.066045423294, 6457.547971642128, 7210.675519601526, 7267.273272672691, 7401.33387995083, 7423.777286681408, 7525.887111693439, 7484.176740558643, 7626.3898888089925, 7675.155732869268, 7703.114141873756, 7774.611269436618, 5092.898142037065, 5692.373838877637, 6115.755369785336, 6176.845578860564, 6213.565050446426, 6048.7278072487725, 6378.362163783585, 6383.425491705769, 6391.041343798467, 6405.8718825624155, 5694.032014557452, 5733.3406658234835, 5772.855678607901, 5836.708164591839, 5846.766129354778, 5636.0, 5712.0, 5763.4812866842185, 5863.824085277449, 5892.440218179266, 5996.970015149896, 6076.301225358963, 6120.051392034242, 6150.876982460236, 6239.251289845248, 5656.095024796013, 5657.8019769307875, 5710.400407957105, 5714.3999880012, 5722.62802917809, 5912.556558258234, 5941.197938278277, 5955.91066134017, 5965.582409231312, 5969.134475501115], "unit": "score", "name": "mootools.html", "value": 3782.486214071674}, {"lowerIsBetter": false, "replicates": [270.98509581972985, 276.0572644419307, 277.97498225159734, 280.2950579293078, 281.853436213169, 5092.974535127329, 5198.844034678966, 5237.554807841333, 5256.0, 5266.81566145185, 5264.447233040533, 5277.208418737182, 5285.682859028461, 5287.41838397776, 5303.071962406573, 3839.5968423315567, 3951.0517475805887, 4048.7368321059184, 4085.673146148301, 4109.260333140033, 4086.16233672098, 4095.5494895561615, 4096.733712308705, 4097.405876147956, 4098.385242213662, 4041.1513582147786, 4051.817668204923, 4056.5943405659345, 4060.167665628539, 4062.309407400734, 4049.1699201663587, 4057.9594204057876, 4058.6550143237564, 4059.573744756817, 4060.614241647039, 3550.7692000020174, 3551.964480355189, 3552.0409489437707, 3552.928941421183, 3553.7690050146657, 5082.059818933509, 5105.923411148836, 5109.565686916617, 5110.386753589556, 5117.0, 4310.181065597558, 4624.653151013687, 4626.86119416418, 4628.051249493846, 4631.374764406795, 5352.705601191933, 5356.330458692663, 5373.408925018245, 5376.247325374451, 5380.704061276629, 3578.159132603836, 3608.6932610728118, 3609.8375573099274, 3617.330793803155, 3633.909152271188, 5595.356533998602, 5696.231008813798, 5791.131330300446, 5815.185873977646, 5821.417858214229, 3794.051487128218, 3819.2743378757946, 3827.770333779926, 3833.0800607853917, 3834.1564855731694, 3879.18537107205, 3884.747491413049, 3888.4361767543546, 3888.9805550972064, 3895.1235971906094, 4510.72935623857, 4520.52534483881, 4523.525029871882, 4524.8416305429155, 4532.229520981441, 5200.92198617021, 5304.681719096867, 5437.483439073281, 5507.228987941691, 5508.20131080991, 1350.8108864758942, 1369.630199846036, 1370.5545697648106, 1371.4856928651755, 1373.368250604733, 848.6138806842872, 865.1521508921293, 870.2646263906988, 875.0767939823547, 903.8011637439753, 4813.78337974792, 4828.758562071953, 4836.081144582518, 4836.250381190921, 4842.249451335048, 5706.4864162225595, 5710.2576665033275, 5711.7429715662065, 5714.514266287412, 5720.970225359392, 4824.855254342376, 4831.371921650233, 4836.371271734652, 4841.685290456109, 4841.830535931296, 3041.9543706844415, 3069.0332545248175, 3070.1250143708935, 3076.1694342527394, 3080.2607374230024, 5410.59420543453, 5411.540019098342, 5416.160495123262, 5418.566514678816, 5424.376196737426, 5683.914741278884, 5859.150423188614, 5860.794872179454, 5943.55423343251, 5951.761929522857, 5438.374586922555, 5459.099248623933, 5460.372057213392, 5461.590380721462, 5464.071107911585, 5750.0512415450985, 5766.509846663081, 5771.3651498335985, 5773.566982476415, 5774.48029677331, 5632.183333416713, 5692.857678558069, 5694.943050569441, 5701.771929122954, 5704.629199102045, 5437.429069947757, 5447.945520544744, 5452.628106773566, 5455.18172274162, 5455.618106732491, 3718.665320121202, 3804.144067584771, 3868.922621547497, 3874.5544262409057, 3877.360235561101, 5488.1493368527945, 5641.26663533738, 5717.542596592346, 5730.455606717355, 5736.340320862987, 5542.916856247079, 5552.833414997556, 5555.972220138873, 5563.0, 5572.4706152915405, 5540.584456165723, 5547.528460080777, 5555.500004999408, 5563.248961390161, 5564.0, 5439.864003399946, 5443.237946687546, 5449.782008719607, 5451.400345961862, 5456.59075569326, 5583.050881350099, 5590.608657393944, 5593.692346920959, 5593.944060559343, 5594.832155035193, 5277.947220527899, 5454.481824226692, 5454.536364409069, 5466.480684334982, 5469.535089517435], "unit": "score", "name": "prototype.html", "value": 4100.502099325986}, {"lowerIsBetter": false, "replicates": [570.9229254050701, 587.5123647372678, 591.1841658511254, 650.6941737383431, 662.1755913887209, 11073.280236784614, 11158.665240042792, 11210.159238057158, 11217.831732524019, 11261.943690281547, 10460.267781255316, 10494.527746251419, 10516.526756295965, 10594.364338139718, 10703.732406689836, 574.0241589298189, 672.4889084295921, 681.8943063825103, 694.7221111555368, 696.9303069693041, 687.2303020616916, 689.3106893106893, 693.2235895796715, 694.472201127142, 694.6249025526209, 719.3777382564097, 723.4501778648239, 723.5297056913022, 724.1563578431121, 724.2829598697278, 598.9880202395949, 706.4313227851577, 714.478430745556, 727.9927200727977, 728.7740800351908, 523.6622378565804, 524.4178961352895, 527.014482916944, 527.9683219006872, 528.1918664443369, 9528.857067143997, 9542.284328675378, 9553.140217380469, 9560.95219523905, 9577.281703872237, 9645.131938125602, 10683.78632427355, 10800.837987430195, 11422.657320280405, 11605.477753501113, 8742.0, 8795.120487951217, 8813.338999575057, 8843.292536597057, 8844.46933184011, 3144.9528257076163, 3197.2486465680545, 3231.482962725976, 3232.127325622069, 3303.9834800826084, 41210.9999999997, 41450.0, 41580.58419415797, 41615.0, 41694.166116677494, 8318.625661845232, 8352.290055345242, 8388.37087218461, 8433.325333973267, 8555.871661925075, 15807.36770529166, 15811.288492017888, 15815.604609884615, 15821.841781582038, 15860.20698965047, 5889.38161493037, 5899.528037756969, 6019.398060193946, 6035.758569657252, 6093.390660933871, 3444.5522082129664, 3502.772319799205, 3604.4773507841214, 3606.332828426697, 3689.7970611616083, 2527.2039307618043, 2528.05198050731, 2540.2506260653154, 2546.1597672767944, 2550.8214424990074, 373.7421179386215, 428.18430889156207, 436.6201404777864, 456.4271838842298, 456.90115272769043, 477.7682823830439, 479.99520004799507, 485.579973323073, 487.7390596031106, 495.4154098164201, 6848.2466928638805, 6852.109225800714, 6976.965115174493, 7161.283871612797, 7204.9279507204255, 468.5789575356522, 481.4944308476156, 484.4562028759612, 484.9830255941025, 508.20719677303526, 3270.3622793555505, 3273.885414010498, 3329.8168600727195, 3345.983270083634, 3379.898603041913, 49210.753946230754, 50878.491215088114, 51457.0, 51569.2264616031, 51615.74192129015, 44857.55142448534, 44992.3251151233, 45286.0, 47083.5291647086, 47722.5227747725, 41039.0, 41503.7924810374, 42217.0, 42251.7887410561, 42393.576064239576, 6767.661616919036, 7003.474739394667, 7123.786286411416, 7192.172900116553, 7207.315305046012, 29981.250468738457, 30437.847810760806, 31204.0, 31802.36395272128, 32103.839480802446, 35498.46752298666, 39733.60266397299, 39909.2018159641, 40251.1949761009, 41434.37848432216, 9072.818543629222, 9080.364374493722, 9252.352335336462, 9277.67528136512, 9297.395669281475, 10001.449920254165, 10154.136898363426, 10283.537240824031, 10577.153827693612, 10592.629257975934, 9493.715188544355, 10215.897841021495, 10246.948765256126, 10442.425666588411, 10774.838377424188, 9849.753756155867, 10023.148032417326, 10132.088112069949, 10150.746231344276, 10351.741206469898, 9874.160696340892, 10019.148372388428, 10470.267081304235, 10522.421266830397, 10982.560697572007, 8321.375896807642, 8449.493030418194, 8532.573371331533, 8556.10160933093, 8647.740567782977, 8144.226298501633, 8559.443636163629, 8606.225439710455, 8673.913260867563, 8989.370744048116], "unit": "score", "name": "yui.html", "value": 5297.429675826799}], "name": "dromaeo_css", "value": 5891.987549361842}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 108.0, 114.0, 114.0, 115.0, 104.0, 115.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [155.0, 151.0, 158.0, 176.0, 136.0, 159.0, 162.0, 134.0, 180.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 154.3}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 100.0, 98.0, 73.0, 74.0, 73.0, 110.0, 97.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 145.0, 95.0, 96.0, 95.0, 146.0, 94.0, 95.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 69.0, 66.0, 66.0, 76.0, 67.0, 77.0, 66.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 68.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 71.0, 72.0, 71.0, 71.0, 71.0, 72.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.2}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 99.0, 84.0, 83.0, 85.0, 83.0, 84.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [119.0, 119.0, 119.0, 121.0, 129.0, 139.0, 138.0, 128.0, 124.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [153.0, 140.0, 153.0, 162.0, 151.0, 149.0, 147.0, 155.0, 140.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.9}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 72.0, 70.0, 69.0, 70.0, 71.0, 70.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1552.5000000000002}]} 13:08:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1552.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "5891.99"}}} 13:08:47 INFO - Return code: 0 13:08:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:08:47 INFO - # TBPL SUCCESS # 13:08:47 INFO - Running post-action listener: _resource_record_post_action 13:08:47 INFO - Running post-run listener: _resource_record_post_run 13:08:48 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540377088; Read time: 16; Write time: 472892 13:08:48 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233218048; Read time: 0; Write time: 257948 13:08:48 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291397632; Read time: 16; Write time: 200920 13:08:48 INFO - Running post-run listener: _upload_blobber_files 13:08:48 INFO - Blob upload gear active. 13:08:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:08:48 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 13:08:48 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'] 13:08:48 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 13:08:48 INFO - (blobuploader) - INFO - Open directory for files ... 13:08:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:08:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:08:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:49 INFO - (blobuploader) - INFO - Done attempting. 13:08:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:08:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:08:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:08:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:08:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:08:50 INFO - (blobuploader) - INFO - Done attempting. 13:08:50 INFO - (blobuploader) - INFO - Iteration through files over. 13:08:50 INFO - Return code: 0 13:08:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:08:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:08:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e07fd77b2383f6876da0822967327ca3d19fb14d10b966d40460c3ec1b4890c5de4c4e4bcac42f664dbb0697e3ec8c68ede3e031691628aa6fca834d4ff3e34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fa3fc8c54267f532e5c5d41f2ca57210a8f2009dee1808ed0126ebd169c95675d15918d702401bd775260cad006e28565797b89b21f98a382cfab1d6c57e165"} 13:08:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:08:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:08:50 INFO - Contents: 13:08:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e07fd77b2383f6876da0822967327ca3d19fb14d10b966d40460c3ec1b4890c5de4c4e4bcac42f664dbb0697e3ec8c68ede3e031691628aa6fca834d4ff3e34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fa3fc8c54267f532e5c5d41f2ca57210a8f2009dee1808ed0126ebd169c95675d15918d702401bd775260cad006e28565797b89b21f98a382cfab1d6c57e165"} 13:08:50 INFO - Running post-run listener: copy_logs_to_upload_dir 13:08:50 INFO - Copying logs to upload dir... 13:08:50 INFO - mkdir: /builds/slave/test/build/upload/logs 13:08:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.991620 ========= master_lag: 37.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-03-01 13:09:27.749950) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 13:09:27.753392) ========= 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=0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e07fd77b2383f6876da0822967327ca3d19fb14d10b966d40460c3ec1b4890c5de4c4e4bcac42f664dbb0697e3ec8c68ede3e031691628aa6fca834d4ff3e34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fa3fc8c54267f532e5c5d41f2ca57210a8f2009dee1808ed0126ebd169c95675d15918d702401bd775260cad006e28565797b89b21f98a382cfab1d6c57e165"} build_url:https://queue.taskcluster.net/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011534 build_url: 'https://queue.taskcluster.net/v1/task/Yj7AHdTtR7qv76_FmyM9VA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e07fd77b2383f6876da0822967327ca3d19fb14d10b966d40460c3ec1b4890c5de4c4e4bcac42f664dbb0697e3ec8c68ede3e031691628aa6fca834d4ff3e34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fa3fc8c54267f532e5c5d41f2ca57210a8f2009dee1808ed0126ebd169c95675d15918d702401bd775260cad006e28565797b89b21f98a382cfab1d6c57e165"}' ========= master_lag: 0.46 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 13:09:28.223954) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 13:09:28.224279) ========= 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=0333a256a5e4f052382dd180000001b1-1456865296.977605-2121050543 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004617 ========= master_lag: 0.26 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 13:09:28.489726) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 13:09:28.490011) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 13:09:28.490574) ========= ========= Total master_lag: 38.18 =========