builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1458235711.53 results: success (0) buildid: 20160317094613 builduid: 68d93a79b4f64423b1897d97c9d49bf6 revision: 090b7c54cbb2e8ab316a78affa65501a7de6a638 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:31.531032) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:31.532125) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:31.532853) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006378 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:31.559096) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:31.559563) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:31.574297) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:31.574808) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004665 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:31.624792) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:31.625117) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:31.625529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:31.625859) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-17 10:28:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 210M=0s 2016-03-17 10:28:32 (210 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093215 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:31.732608) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:31.733036) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021261 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:31.787403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 10:28:31.788265) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 090b7c54cbb2e8ab316a78affa65501a7de6a638 --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 090b7c54cbb2e8ab316a78affa65501a7de6a638 --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=14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-17 10:28:32,361 truncating revision to first 12 chars 2016-03-17 10:28:32,361 Setting DEBUG logging. 2016-03-17 10:28:32,361 attempt 1/10 2016-03-17 10:28:32,361 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/090b7c54cbb2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 10:28:33,057 unpacking tar archive at: fx-team-090b7c54cbb2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.007204 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-17 10:28:32.812295) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:32.813167) ========= echo 090b7c54cbb2e8ab316a78affa65501a7de6a638 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'090b7c54cbb2e8ab316a78affa65501a7de6a638'] 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=14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 090b7c54cbb2e8ab316a78affa65501a7de6a638 program finished with exit code 0 elapsedTime=0.004930 script_repo_revision: '090b7c54cbb2e8ab316a78affa65501a7de6a638' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:32.867641) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:32.868269) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 10:28:32.880389) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-17 10:28:32.880718) ========= /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=14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:28:33 INFO - MultiFileLogger online at 20160317 10:28:33 in /builds/slave/test 10:28:33 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 10:28:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:28:33 INFO - {'append_to_log': False, 10:28:33 INFO - 'base_work_dir': '/builds/slave/test', 10:28:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:28:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:28:33 INFO - 'branch': 'Fx-Team-Non-PGO', 10:28:33 INFO - 'buildbot_json_path': 'buildprops.json', 10:28:33 INFO - 'config_files': ('talos/linux_config.py',), 10:28:33 INFO - 'default_actions': ('clobber', 10:28:33 INFO - 'read-buildbot-config', 10:28:33 INFO - 'download-and-extract', 10:28:33 INFO - 'populate-webroot', 10:28:33 INFO - 'create-virtualenv', 10:28:33 INFO - 'install', 10:28:33 INFO - 'run-tests'), 10:28:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:28:33 INFO - 'download_minidump_stackwalk': True, 10:28:33 INFO - 'download_symbols': 'ondemand', 10:28:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:28:33 INFO - 'tooltool.py': '/tools/tooltool.py', 10:28:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:28:33 INFO - '/tools/misc-python/virtualenv.py')}, 10:28:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:28:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:28:33 INFO - 'installer_path': 'installer.exe', 10:28:33 INFO - 'log_level': 'info', 10:28:33 INFO - 'log_name': 'talos', 10:28:33 INFO - 'log_to_console': True, 10:28:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:28:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:28:33 INFO - 'opt_config_files': (), 10:28:33 INFO - 'pip_index': False, 10:28:33 INFO - 'sps_profile': False, 10:28:33 INFO - 'sps_profile_interval': 0, 10:28:33 INFO - 'suite': 'dromaeojs', 10:28:33 INFO - 'system_bits': '32', 10:28:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:28:33 INFO - 'title': 'talos-linux64-ix-036', 10:28:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:28:33 INFO - 'use_talos_json': True, 10:28:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:28:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:28:33 INFO - 'work_dir': 'build'} 10:28:33 INFO - ##### 10:28:33 INFO - ##### Running clobber step. 10:28:33 INFO - ##### 10:28:33 INFO - Running pre-action listener: _resource_record_pre_action 10:28:33 INFO - Running main action method: clobber 10:28:33 INFO - rmtree: /builds/slave/test/build 10:28:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:28:34 INFO - Running post-action listener: _resource_record_post_action 10:28:34 INFO - ##### 10:28:34 INFO - ##### Running read-buildbot-config step. 10:28:34 INFO - ##### 10:28:34 INFO - Running pre-action listener: _resource_record_pre_action 10:28:34 INFO - Running main action method: read_buildbot_config 10:28:34 INFO - Using buildbot properties: 10:28:34 INFO - { 10:28:34 INFO - "project": "", 10:28:34 INFO - "product": "firefox", 10:28:34 INFO - "script_repo_revision": "production", 10:28:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:28:34 INFO - "repository": "", 10:28:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:28:34 INFO - "buildid": "20160317094613", 10:28:34 INFO - "pgo_build": "False", 10:28:34 INFO - "basedir": "/builds/slave/test", 10:28:34 INFO - "buildnumber": 1464, 10:28:34 INFO - "slavename": "talos-linux64-ix-036", 10:28:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:28:34 INFO - "platform": "ubuntu64_hw", 10:28:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:28:34 INFO - "branch": "fx-team", 10:28:34 INFO - "repo_path": "integration/fx-team", 10:28:34 INFO - "revision": "090b7c54cbb2e8ab316a78affa65501a7de6a638", 10:28:34 INFO - "stage_platform": "linux64", 10:28:34 INFO - "builduid": "68d93a79b4f64423b1897d97c9d49bf6", 10:28:34 INFO - "slavebuilddir": "test" 10:28:34 INFO - } 10:28:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 10:28:34 INFO - Running post-action listener: _resource_record_post_action 10:28:34 INFO - ##### 10:28:34 INFO - ##### Running download-and-extract step. 10:28:34 INFO - ##### 10:28:34 INFO - Running pre-action listener: _resource_record_pre_action 10:28:34 INFO - Running main action method: download_and_extract 10:28:34 INFO - mkdir: /builds/slave/test/build/tests 10:28: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')]} 10:28:34 INFO - https://queue.taskcluster.net/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:28:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:28:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:28:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:28:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:28:34 INFO - Downloaded 1361 bytes. 10:28:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:28:34 INFO - Using the following test package requirements: 10:28:34 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:28:34 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:28:34 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:28:34 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:34 INFO - u'jsshell-linux-x86_64.zip'], 10:28:34 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:28:34 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:28:34 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:28:34 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:28:34 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:28:34 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:28:34 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:28:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:28: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')]} 10:28:34 INFO - https://queue.taskcluster.net/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:28:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:28:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:28:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:28:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:28:35 INFO - Downloaded 22008941 bytes. 10:28:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:28:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:28:37 INFO - Return code: 0 10:28:37 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:37 INFO - https://queue.taskcluster.net/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:28:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:28:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:28:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:28:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:28:38 INFO - Downloaded 22008941 bytes. 10:28:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:28:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:28:39 INFO - Return code: 0 10:28: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')]} 10:28:39 INFO - https://queue.taskcluster.net/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:28:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:28:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:28:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:28:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:28:40 INFO - Downloaded 10846565 bytes. 10:28:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:28:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:28:40 INFO - Return code: 0 10:28:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:40 INFO - https://queue.taskcluster.net/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:28:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:28:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:28:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:28:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:28:42 INFO - Downloaded 54154159 bytes. 10:28:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:28:42 INFO - mkdir: /builds/slave/test/properties 10:28:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:28:42 INFO - Writing to file /builds/slave/test/properties/build_url 10:28:42 INFO - Contents: 10:28:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:28:42 INFO - Running post-action listener: _resource_record_post_action 10:28:42 INFO - Running post-action listener: set_extra_try_arguments 10:28:42 INFO - ##### 10:28:42 INFO - ##### Running populate-webroot step. 10:28:42 INFO - ##### 10:28:42 INFO - Running pre-action listener: _resource_record_pre_action 10:28:42 INFO - Running main action method: populate_webroot 10:28:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:28:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:28:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:28:42 INFO - '--tppagecycles', 10:28:42 INFO - '7'], 10:28:42 INFO - 'tests': ['tsvgm']}}, 10:28:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:28:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:28:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:28:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:28:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:28:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:28:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:28:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:42 INFO - 'talos_options': ['--e10s'], 10:28:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:28:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:42 INFO - 'tests': ['damp', 'tps']}, 10:28:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:42 INFO - 'talos_options': ['--e10s'], 10:28:42 INFO - 'tests': ['damp', 'tps']}, 10:28:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:28:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:28:42 INFO - 'other': {'tests': ['a11yr', 10:28:42 INFO - 'ts_paint', 10:28:42 INFO - 'tpaint', 10:28:42 INFO - 'sessionrestore', 10:28:42 INFO - 'sessionrestore_no_auto_restore', 10:28:42 INFO - 'tabpaint']}, 10:28:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:28:42 INFO - 'tests': ['a11yr', 10:28:42 INFO - 'ts_paint', 10:28:42 INFO - 'tpaint', 10:28:42 INFO - 'sessionrestore', 10:28:42 INFO - 'sessionrestore_no_auto_restore', 10:28:42 INFO - 'tabpaint']}, 10:28:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:28:42 INFO - 'tests': ['a11yr', 10:28:42 INFO - 'ts_paint', 10:28:42 INFO - 'tpaint', 10:28:42 INFO - 'sessionrestore', 10:28:42 INFO - 'sessionrestore_no_auto_restore', 10:28:42 INFO - 'tabpaint']}, 10:28:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:28:42 INFO - 'tests': ['a11yr', 10:28:42 INFO - 'ts_paint', 10:28:42 INFO - 'tpaint', 10:28:42 INFO - 'sessionrestore', 10:28:42 INFO - 'sessionrestore_no_auto_restore', 10:28:42 INFO - 'tabpaint']}, 10:28:42 INFO - 'other_l64': {'tests': ['a11yr', 10:28:42 INFO - 'ts_paint', 10:28:42 INFO - 'tpaint', 10:28:42 INFO - 'sessionrestore', 10:28:42 INFO - 'sessionrestore_no_auto_restore', 10:28:42 INFO - 'tabpaint']}, 10:28:42 INFO - 'other_nol64': {'tests': ['a11yr', 10:28:42 INFO - 'ts_paint', 10:28:42 INFO - 'tpaint', 10:28:42 INFO - 'sessionrestore', 10:28:42 INFO - 'sessionrestore_no_auto_restore', 10:28:42 INFO - 'tabpaint']}, 10:28:42 INFO - 'svgr': {'tests': ['tsvgx', 10:28:42 INFO - 'tsvgr_opacity', 10:28:42 INFO - 'tart', 10:28:42 INFO - 'tscrollx', 10:28:42 INFO - 'cart']}, 10:28:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:28:42 INFO - 'tests': ['tsvgx', 10:28:42 INFO - 'tsvgr_opacity', 10:28:42 INFO - 'tart', 10:28:42 INFO - 'tscrollx', 10:28:42 INFO - 'cart']}, 10:28:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:42 INFO - 'tests': ['tp5o']}, 10:28:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:42 INFO - 'talos_options': ['--e10s'], 10:28:42 INFO - 'tests': ['tp5o']}, 10:28:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:42 INFO - 'talos_options': ['--xperf_path', 10:28:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:28:42 INFO - 'tests': ['tp5n']}, 10:28:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:42 INFO - 'talos_options': ['--e10s', 10:28:42 INFO - '--xperf_path', 10:28:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:28:42 INFO - 'tests': ['tp5n']}}, 10:28:42 INFO - 'talos.zip': {'path': '', 10:28:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:28:42 INFO - Running post-action listener: _resource_record_post_action 10:28:42 INFO - ##### 10:28:42 INFO - ##### Running create-virtualenv step. 10:28:42 INFO - ##### 10:28:42 INFO - Running pre-action listener: _resource_record_pre_action 10:28:42 INFO - Running main action method: create_virtualenv 10:28:42 INFO - Creating virtualenv /builds/slave/test/build/venv 10:28:42 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 10:28:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:28:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:28:42 INFO - Using real prefix '/usr' 10:28:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:28:43 INFO - Installing distribute.............................................................................................................................................................................................done. 10:28:45 INFO - Installing pip.................done. 10:28:45 INFO - Return code: 0 10:28:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6102d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072410>, '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 0x2073310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20737a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', '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 10:28:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:28:45 INFO - Using env: {'DISPLAY': ':0', 10:28:45 INFO - 'HOME': '/home/cltbld', 10:28:45 INFO - 'LANG': 'en_US.UTF-8', 10:28:45 INFO - 'LANGUAGE': 'en_US:en', 10:28:45 INFO - 'LOGNAME': 'cltbld', 10:28:45 INFO - 'MAIL': '/var/mail/cltbld', 10:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:45 INFO - 'MOZ_NO_REMOTE': '1', 10:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:45 INFO - 'NO_EM_RESTART': '1', 10:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:45 INFO - 'PWD': '/builds/slave/test', 10:28:45 INFO - 'SHELL': '/bin/bash', 10:28:45 INFO - 'SHLVL': '1', 10:28:45 INFO - 'TERM': 'linux', 10:28:45 INFO - 'TMOUT': '86400', 10:28:45 INFO - 'USER': 'cltbld', 10:28:45 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', 10:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:45 INFO - '_': '/tools/buildbot/bin/python'} 10:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:45 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 10:28:45 INFO - Cleaning up... 10:28:45 INFO - Return code: 0 10:28:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe6102d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072410>, '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 0x2073310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20737a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', '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 10:28:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:28:45 INFO - Using env: {'DISPLAY': ':0', 10:28:45 INFO - 'HOME': '/home/cltbld', 10:28:45 INFO - 'LANG': 'en_US.UTF-8', 10:28:45 INFO - 'LANGUAGE': 'en_US:en', 10:28:45 INFO - 'LOGNAME': 'cltbld', 10:28:45 INFO - 'MAIL': '/var/mail/cltbld', 10:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:45 INFO - 'MOZ_NO_REMOTE': '1', 10:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:45 INFO - 'NO_EM_RESTART': '1', 10:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:45 INFO - 'PWD': '/builds/slave/test', 10:28:45 INFO - 'SHELL': '/bin/bash', 10:28:45 INFO - 'SHLVL': '1', 10:28:45 INFO - 'TERM': 'linux', 10:28:45 INFO - 'TMOUT': '86400', 10:28:45 INFO - 'USER': 'cltbld', 10:28:45 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', 10:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:45 INFO - '_': '/tools/buildbot/bin/python'} 10:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:45 INFO - Downloading/unpacking psutil>=0.7.1 10:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:28:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:28:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:28:47 INFO - Installing collected packages: psutil 10:28:47 INFO - Running setup.py install for psutil 10:28:47 INFO - building 'psutil._psutil_linux' extension 10:28:47 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 10:28:48 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 10:28:48 INFO - building 'psutil._psutil_posix' extension 10:28:48 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 10:28:48 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 10:28:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:28:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:28:48 INFO - Successfully installed psutil 10:28:48 INFO - Cleaning up... 10:28:48 INFO - Return code: 0 10:28:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:28:48 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')]} 10:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:48 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')]} 10:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:48 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 0x7fe6102d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072410>, '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 0x2073310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20737a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', '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 10:28:48 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 10:28:48 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 10:28:48 INFO - Using env: {'DISPLAY': ':0', 10:28:48 INFO - 'HOME': '/home/cltbld', 10:28:48 INFO - 'LANG': 'en_US.UTF-8', 10:28:48 INFO - 'LANGUAGE': 'en_US:en', 10:28:48 INFO - 'LOGNAME': 'cltbld', 10:28:48 INFO - 'MAIL': '/var/mail/cltbld', 10:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:48 INFO - 'MOZ_NO_REMOTE': '1', 10:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:48 INFO - 'NO_EM_RESTART': '1', 10:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:48 INFO - 'PWD': '/builds/slave/test', 10:28:48 INFO - 'SHELL': '/bin/bash', 10:28:48 INFO - 'SHLVL': '1', 10:28:48 INFO - 'TERM': 'linux', 10:28:48 INFO - 'TMOUT': '86400', 10:28:48 INFO - 'USER': 'cltbld', 10:28:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', 10:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:48 INFO - '_': '/tools/buildbot/bin/python'} 10:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:28: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 10:28: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 10:28: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 10:28: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 10:28: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 10:28: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 10:28:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:28:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:28:50 INFO - Installing collected packages: mozsystemmonitor 10:28:50 INFO - Running setup.py install for mozsystemmonitor 10:28:50 INFO - Successfully installed mozsystemmonitor 10:28:50 INFO - Cleaning up... 10:28:50 INFO - Return code: 0 10:28:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe6102d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072410>, '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 0x2073310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20737a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', '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 10:28:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:28:50 INFO - Using env: {'DISPLAY': ':0', 10:28:50 INFO - 'HOME': '/home/cltbld', 10:28:50 INFO - 'LANG': 'en_US.UTF-8', 10:28:50 INFO - 'LANGUAGE': 'en_US:en', 10:28:50 INFO - 'LOGNAME': 'cltbld', 10:28:50 INFO - 'MAIL': '/var/mail/cltbld', 10:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:50 INFO - 'MOZ_NO_REMOTE': '1', 10:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:50 INFO - 'NO_EM_RESTART': '1', 10:28:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:50 INFO - 'PWD': '/builds/slave/test', 10:28:50 INFO - 'SHELL': '/bin/bash', 10:28:50 INFO - 'SHLVL': '1', 10:28:50 INFO - 'TERM': 'linux', 10:28:50 INFO - 'TMOUT': '86400', 10:28:50 INFO - 'USER': 'cltbld', 10:28:50 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', 10:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:50 INFO - '_': '/tools/buildbot/bin/python'} 10:28:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:50 INFO - Downloading/unpacking blobuploader==1.2.4 10:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:52 INFO - Downloading blobuploader-1.2.4.tar.gz 10:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:28:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:28:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:53 INFO - Downloading docopt-0.6.1.tar.gz 10:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:28:53 INFO - Installing collected packages: blobuploader, requests, docopt 10:28:53 INFO - Running setup.py install for blobuploader 10:28:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:28:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:28:53 INFO - Running setup.py install for requests 10:28:54 INFO - Running setup.py install for docopt 10:28:54 INFO - Successfully installed blobuploader requests docopt 10:28:54 INFO - Cleaning up... 10:28:54 INFO - Return code: 0 10:28:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:54 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')]} 10:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:54 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')]} 10:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:54 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 0x7fe6102d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072410>, '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 0x2073310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20737a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', '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 10:28:54 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 10:28:54 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 10:28:54 INFO - Using env: {'DISPLAY': ':0', 10:28:54 INFO - 'HOME': '/home/cltbld', 10:28:54 INFO - 'LANG': 'en_US.UTF-8', 10:28:54 INFO - 'LANGUAGE': 'en_US:en', 10:28:54 INFO - 'LOGNAME': 'cltbld', 10:28:54 INFO - 'MAIL': '/var/mail/cltbld', 10:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:54 INFO - 'MOZ_NO_REMOTE': '1', 10:28:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:54 INFO - 'NO_EM_RESTART': '1', 10:28:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:54 INFO - 'PWD': '/builds/slave/test', 10:28:54 INFO - 'SHELL': '/bin/bash', 10:28:54 INFO - 'SHLVL': '1', 10:28:54 INFO - 'TERM': 'linux', 10:28:54 INFO - 'TMOUT': '86400', 10:28:54 INFO - 'USER': 'cltbld', 10:28:54 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', 10:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:54 INFO - '_': '/tools/buildbot/bin/python'} 10:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:28:54 INFO - Running setup.py (path:/tmp/pip-YIAaXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:28:54 INFO - Running setup.py (path:/tmp/pip-MdXup_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:28:54 INFO - Running setup.py (path:/tmp/pip-hx5rm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:28:54 INFO - Running setup.py (path:/tmp/pip-sn5HSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:28:54 INFO - Running setup.py (path:/tmp/pip-MMsxyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:28:54 INFO - Running setup.py (path:/tmp/pip-1q2E7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:28:54 INFO - Running setup.py (path:/tmp/pip-QyrjTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:28:54 INFO - Running setup.py (path:/tmp/pip-bfsFqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:28:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:28:54 INFO - Running setup.py (path:/tmp/pip-yWPGEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:28:55 INFO - Running setup.py (path:/tmp/pip-M0nD5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:28:55 INFO - Running setup.py (path:/tmp/pip-UvNcF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:28:55 INFO - Running setup.py (path:/tmp/pip-VopJeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:28:55 INFO - Running setup.py (path:/tmp/pip-LPOfUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:28:55 INFO - Running setup.py (path:/tmp/pip-PlhLwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:55 INFO - Running setup.py (path:/tmp/pip-fzi4uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:28:55 INFO - Running setup.py (path:/tmp/pip-HKdpPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:28:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:28:55 INFO - Running setup.py (path:/tmp/pip-t2aVBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:28:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:28:55 INFO - Running setup.py install for manifestparser 10:28:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:28:55 INFO - Running setup.py install for mozcrash 10:28:55 INFO - Running setup.py install for mozdebug 10:28:55 INFO - Running setup.py install for mozdevice 10:28:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:28:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:28:56 INFO - Running setup.py install for mozfile 10:28:56 INFO - Running setup.py install for mozhttpd 10:28:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:28:56 INFO - Running setup.py install for mozinfo 10:28:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:28:56 INFO - Running setup.py install for mozInstall 10:28:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:28:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:28:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:28:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:28:56 INFO - Running setup.py install for mozleak 10:28:56 INFO - Running setup.py install for mozlog 10:28:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:28:56 INFO - Running setup.py install for moznetwork 10:28:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:28:56 INFO - Running setup.py install for mozprocess 10:28:56 INFO - Running setup.py install for mozprofile 10:28:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:28:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:28:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:28:56 INFO - Running setup.py install for mozrunner 10:28:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:28:57 INFO - Running setup.py install for mozscreenshot 10:28:57 INFO - Running setup.py install for moztest 10:28:57 INFO - Running setup.py install for mozversion 10:28:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:28:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:28:57 INFO - Cleaning up... 10:28:57 INFO - Return code: 0 10:28:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:57 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')]} 10:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:57 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')]} 10:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:57 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 0x7fe6102d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072410>, '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 0x2073310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20737a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', '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 10:28:57 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 10:28:57 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 10:28:57 INFO - Using env: {'DISPLAY': ':0', 10:28:57 INFO - 'HOME': '/home/cltbld', 10:28:57 INFO - 'LANG': 'en_US.UTF-8', 10:28:57 INFO - 'LANGUAGE': 'en_US:en', 10:28:57 INFO - 'LOGNAME': 'cltbld', 10:28:57 INFO - 'MAIL': '/var/mail/cltbld', 10:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:57 INFO - 'MOZ_NO_REMOTE': '1', 10:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:28:57 INFO - 'NO_EM_RESTART': '1', 10:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:57 INFO - 'PWD': '/builds/slave/test', 10:28:57 INFO - 'SHELL': '/bin/bash', 10:28:57 INFO - 'SHLVL': '1', 10:28:57 INFO - 'TERM': 'linux', 10:28:57 INFO - 'TMOUT': '86400', 10:28:57 INFO - 'USER': 'cltbld', 10:28:57 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', 10:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:57 INFO - '_': '/tools/buildbot/bin/python'} 10:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:28:57 INFO - Running setup.py (path:/tmp/pip-25rPpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:28:57 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)) 10:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:28:57 INFO - Running setup.py (path:/tmp/pip-MWThwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:28:57 INFO - Running setup.py (path:/tmp/pip-r2ogEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:28:57 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)) 10:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:28:57 INFO - Running setup.py (path:/tmp/pip-g7kpbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:28:57 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)) 10:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:28:57 INFO - Running setup.py (path:/tmp/pip-T2gbrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:28:57 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)) 10:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:28:57 INFO - Running setup.py (path:/tmp/pip-VFO83g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:28:58 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)) 10:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:28:58 INFO - Running setup.py (path:/tmp/pip-0VfxhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:28:58 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)) 10:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:28:58 INFO - Running setup.py (path:/tmp/pip-wTBJgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:28:58 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)) 10:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:28:58 INFO - Running setup.py (path:/tmp/pip-_afLvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:28:58 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)) 10:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:28:58 INFO - Running setup.py (path:/tmp/pip-DX4TMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:28:58 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)) 10:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:28:58 INFO - Running setup.py (path:/tmp/pip-deRpT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:28:58 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)) 10:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:28:58 INFO - Running setup.py (path:/tmp/pip-N6kPGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:28:58 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)) 10:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:28:58 INFO - Running setup.py (path:/tmp/pip-JgGsJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:28:58 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)) 10:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:28:58 INFO - Running setup.py (path:/tmp/pip-b9quKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:28:58 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)) 10:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:58 INFO - Running setup.py (path:/tmp/pip-rD6N_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:58 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)) 10:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:28:58 INFO - Running setup.py (path:/tmp/pip-kXMjNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:28:58 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)) 10:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:28:58 INFO - Running setup.py (path:/tmp/pip-2veIls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:28:58 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)) 10:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:28:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:28:58 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)) 10:28:58 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)) 10:28:58 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)) 10:28:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:28:58 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 10:28:58 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 10:28:58 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 10:28:58 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 10:28:58 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 10:28:58 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 10:29:00 INFO - Downloading blessings-1.6.tar.gz 10:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:29:00 INFO - Installing collected packages: blessings 10:29:00 INFO - Running setup.py install for blessings 10:29:00 INFO - Successfully installed blessings 10:29:00 INFO - Cleaning up... 10:29:00 INFO - Return code: 0 10:29:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:29:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:29:01 INFO - Reading from file tmpfile_stdout 10:29:01 INFO - Current package versions: 10:29:01 INFO - argparse == 1.2.1 10:29:01 INFO - blessings == 1.6 10:29:01 INFO - blobuploader == 1.2.4 10:29:01 INFO - docopt == 0.6.1 10:29:01 INFO - manifestparser == 1.1 10:29:01 INFO - mozInstall == 1.12 10:29:01 INFO - mozcrash == 0.17 10:29:01 INFO - mozdebug == 0.1 10:29:01 INFO - mozdevice == 0.48 10:29:01 INFO - mozfile == 1.2 10:29:01 INFO - mozhttpd == 0.7 10:29:01 INFO - mozinfo == 0.9 10:29:01 INFO - mozleak == 0.1 10:29:01 INFO - mozlog == 3.1 10:29:01 INFO - moznetwork == 0.27 10:29:01 INFO - mozprocess == 0.22 10:29:01 INFO - mozprofile == 0.28 10:29:01 INFO - mozrunner == 6.11 10:29:01 INFO - mozscreenshot == 0.1 10:29:01 INFO - mozsystemmonitor == 0.0 10:29:01 INFO - moztest == 0.7 10:29:01 INFO - mozversion == 1.4 10:29:01 INFO - psutil == 3.1.1 10:29:01 INFO - requests == 1.2.3 10:29:01 INFO - wsgiref == 0.1.2 10:29:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:01 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 0x7fe6102d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072410>, '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 0x2073310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20737a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', '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 10:29:01 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 10:29:01 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 10:29:01 INFO - Using env: {'DISPLAY': ':0', 10:29:01 INFO - 'HOME': '/home/cltbld', 10:29:01 INFO - 'LANG': 'en_US.UTF-8', 10:29:01 INFO - 'LANGUAGE': 'en_US:en', 10:29:01 INFO - 'LOGNAME': 'cltbld', 10:29:01 INFO - 'MAIL': '/var/mail/cltbld', 10:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:01 INFO - 'MOZ_NO_REMOTE': '1', 10:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:01 INFO - 'NO_EM_RESTART': '1', 10:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:01 INFO - 'PWD': '/builds/slave/test', 10:29:01 INFO - 'SHELL': '/bin/bash', 10:29:01 INFO - 'SHLVL': '1', 10:29:01 INFO - 'TERM': 'linux', 10:29:01 INFO - 'TMOUT': '86400', 10:29:01 INFO - 'USER': 'cltbld', 10:29:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', 10:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:01 INFO - '_': '/tools/buildbot/bin/python'} 10:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:01 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)) 10:29:01 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)) 10:29:01 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)) 10:29:01 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)) 10:29:01 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)) 10:29:01 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)) 10:29:01 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)) 10:29:01 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)) 10:29:01 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)) 10:29:01 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)) 10:29:01 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)) 10:29:01 INFO - Cleaning up... 10:29:01 INFO - Return code: 0 10:29:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6102d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072410>, '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 0x2073310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20737a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', '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 10:29:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:29:01 INFO - Using env: {'DISPLAY': ':0', 10:29:01 INFO - 'HOME': '/home/cltbld', 10:29:01 INFO - 'LANG': 'en_US.UTF-8', 10:29:01 INFO - 'LANGUAGE': 'en_US:en', 10:29:01 INFO - 'LOGNAME': 'cltbld', 10:29:01 INFO - 'MAIL': '/var/mail/cltbld', 10:29:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:01 INFO - 'MOZ_NO_REMOTE': '1', 10:29:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:01 INFO - 'NO_EM_RESTART': '1', 10:29:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:01 INFO - 'PWD': '/builds/slave/test', 10:29:01 INFO - 'SHELL': '/bin/bash', 10:29:01 INFO - 'SHLVL': '1', 10:29:01 INFO - 'TERM': 'linux', 10:29:01 INFO - 'TMOUT': '86400', 10:29:01 INFO - 'USER': 'cltbld', 10:29:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', 10:29:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:01 INFO - '_': '/tools/buildbot/bin/python'} 10:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:01 INFO - Downloading/unpacking jsonschema 10:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:29:03 INFO - Downloading/unpacking functools32 (from jsonschema) 10:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:03 INFO - Downloading functools32-3.2.3-2.tar.gz 10:29:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:29:03 INFO - warning: no files found matching '*.txt' 10:29:03 INFO - no previously-included directories found matching 'build' 10:29:03 INFO - no previously-included directories found matching 'dist' 10:29:03 INFO - no previously-included directories found matching '.git*' 10:29:03 INFO - Installing collected packages: jsonschema, functools32 10:29:03 INFO - Running setup.py install for functools32 10:29:03 INFO - warning: no files found matching '*.txt' 10:29:03 INFO - no previously-included directories found matching 'build' 10:29:03 INFO - no previously-included directories found matching 'dist' 10:29:03 INFO - no previously-included directories found matching '.git*' 10:29:03 INFO - Successfully installed jsonschema functools32 10:29:03 INFO - Cleaning up... 10:29:03 INFO - Return code: 0 10:29:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:29:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6102d5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2072410>, '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 0x2073310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20737a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', '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 10:29:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:29:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:29:03 INFO - Using env: {'DISPLAY': ':0', 10:29:03 INFO - 'HOME': '/home/cltbld', 10:29:03 INFO - 'LANG': 'en_US.UTF-8', 10:29:03 INFO - 'LANGUAGE': 'en_US:en', 10:29:03 INFO - 'LOGNAME': 'cltbld', 10:29:03 INFO - 'MAIL': '/var/mail/cltbld', 10:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:03 INFO - 'MOZ_NO_REMOTE': '1', 10:29:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:03 INFO - 'NO_EM_RESTART': '1', 10:29:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:03 INFO - 'PWD': '/builds/slave/test', 10:29:03 INFO - 'SHELL': '/bin/bash', 10:29:03 INFO - 'SHLVL': '1', 10:29:03 INFO - 'TERM': 'linux', 10:29:03 INFO - 'TMOUT': '86400', 10:29:03 INFO - 'USER': 'cltbld', 10:29:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', 10:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:03 INFO - '_': '/tools/buildbot/bin/python'} 10:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:29:04 INFO - Downloading/unpacking flake8 10:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:29:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:29:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:29:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:29:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:29:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:29:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:29:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:29:06 INFO - no previously-included directories found matching 'docs/_build' 10:29:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:29:06 INFO - Running setup.py install for pep8 10:29:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:29:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:29:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:29:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:29:06 INFO - no previously-included directories found matching 'docs/_build' 10:29:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:29:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:29:06 INFO - Cleaning up... 10:29:06 INFO - Return code: 0 10:29:06 INFO - Running post-action listener: _resource_record_post_action 10:29:06 INFO - Running post-action listener: _start_resource_monitoring 10:29:06 INFO - Starting resource monitoring. 10:29:06 INFO - ##### 10:29:06 INFO - ##### Running install step. 10:29:06 INFO - ##### 10:29:06 INFO - Running pre-action listener: _resource_record_pre_action 10:29:06 INFO - Running main action method: install 10:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:29:07 INFO - Reading from file tmpfile_stdout 10:29:07 INFO - Detecting whether we're running mozinstall >=1.0... 10:29:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:29:07 INFO - Reading from file tmpfile_stdout 10:29:07 INFO - Output received: 10:29:07 INFO - Usage: mozinstall [options] installer 10:29:07 INFO - Options: 10:29:07 INFO - -h, --help show this help message and exit 10:29:07 INFO - -d DEST, --destination=DEST 10:29:07 INFO - Directory to install application into. [default: 10:29:07 INFO - "/builds/slave/test"] 10:29:07 INFO - --app=APP Application being installed. [default: firefox] 10:29:07 INFO - mkdir: /builds/slave/test/build/application 10:29:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:29:22 INFO - Reading from file tmpfile_stdout 10:29:22 INFO - Output received: 10:29:22 INFO - /builds/slave/test/build/application/firefox/firefox 10:29:22 INFO - Running post-action listener: _resource_record_post_action 10:29:22 INFO - ##### 10:29:22 INFO - ##### Running run-tests step. 10:29:22 INFO - ##### 10:29:22 INFO - Running pre-action listener: _resource_record_pre_action 10:29:22 INFO - Running main action method: run_tests 10:29:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:29:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:29:22 INFO - Python 2.7.3 10:29:22 INFO - Return code: 0 10:29:22 INFO - grabbing minidump binary from tooltool 10:29: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')]} 10:29:22 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 0x2072410>, '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 0x2073310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20737a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:29:22 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 10:29:22 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 10:29:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:29:22 INFO - Return code: 0 10:29:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:29:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:29:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:29:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:29:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:29:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:29:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:29:23 INFO - Return code: 0 10:29:23 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/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 10:29:23 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/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 10:29:23 INFO - Using env: {'DISPLAY': ':0', 10:29:23 INFO - 'HOME': '/home/cltbld', 10:29:23 INFO - 'LANG': 'en_US.UTF-8', 10:29:23 INFO - 'LANGUAGE': 'en_US:en', 10:29:23 INFO - 'LOGNAME': 'cltbld', 10:29:23 INFO - 'MAIL': '/var/mail/cltbld', 10:29:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:29:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:23 INFO - 'MOZ_NO_REMOTE': '1', 10:29:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:29:23 INFO - 'NO_EM_RESTART': '1', 10:29:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:23 INFO - 'PWD': '/builds/slave/test', 10:29:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:29:23 INFO - 'SHELL': '/bin/bash', 10:29:23 INFO - 'SHLVL': '1', 10:29:23 INFO - 'TERM': 'linux', 10:29:23 INFO - 'TMOUT': '86400', 10:29:23 INFO - 'USER': 'cltbld', 10:29:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088', 10:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:23 INFO - '_': '/tools/buildbot/bin/python'} 10:29:23 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/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 10:29:24 INFO - mozversion application_buildid: 20160317094613 10:29:24 INFO - mozversion application_changeset: 090b7c54cbb2e8ab316a78affa65501a7de6a638 10:29:24 INFO - mozversion application_display_name: Nightly 10:29:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:29:24 INFO - mozversion application_name: Firefox 10:29:24 INFO - mozversion application_remotingname: firefox 10:29:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:29:24 INFO - mozversion application_vendor: Mozilla 10:29:24 INFO - mozversion application_version: 48.0a1 10:29:24 INFO - mozversion platform_buildid: 20160317094613 10:29:24 INFO - mozversion platform_changeset: 090b7c54cbb2e8ab316a78affa65501a7de6a638 10:29:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:29:24 INFO - mozversion platform_version: 48.0a1 10:29:24 INFO - using testdate: 1458235764 10:29:24 INFO - actual date: 1458235764 10:29:24 INFO - starting webserver on 'localhost:44148' 10:29:24 INFO - SUITE-START | Running 2 tests 10:29:24 INFO - TEST-START | dromaeo_css 10:29:24 INFO - operating with platform_type : linux_ 10:29:24 INFO - Initialising browser for dromaeo_css test... 10:29:24 INFO - TEST-INFO | started process 1073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSZvEeE/profile http://localhost:44148/getInfo.html) 10:29:28 INFO - PROCESS | 1073 | __metrics Screen width/height:1600/1200 10:29:28 INFO - PROCESS | 1073 | colorDepth:24 10:29:28 INFO - PROCESS | 1073 | Browser inner width/height: 1024/697 10:29:28 INFO - PROCESS | 1073 | __metrics 10:29:29 ERROR - PROCESS | 1073 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:29:29 INFO - PROCESS | 1073 | 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. 10:29:30 INFO - TEST-INFO | 1073: exit 0 10:29:30 INFO - Browser initialized. 10:29:30 INFO - Running cycle 1/1 for dromaeo_css test... 10:29:30 INFO - TEST-INFO | started process 1182 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSZvEeE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:29:42 INFO - PROCESS | 1182 | RSS: Main: 154742784 10:29:42 INFO - PROCESS | 1182 | 10:30:33 INFO - PROCESS | 1182 | 1458235833607 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] 10:32:44 INFO - PROCESS | 1182 | Cycle 1(1): loaded http://localhost:44148/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44148/tests/dromaeo/cssquery-ext.html) 10:32:46 INFO - PROCESS | 1182 | RSS: Main: 268886016 10:32:46 INFO - PROCESS | 1182 | 10:35:48 INFO - PROCESS | 1182 | Cycle 1(1): loaded http://localhost:44148/tests/dromaeo/cssquery-ext.html (next: http://localhost:44148/tests/dromaeo/cssquery-jquery.html) 10:35:49 INFO - PROCESS | 1182 | RSS: Main: 235425792 10:35:49 INFO - PROCESS | 1182 | 10:38:50 INFO - PROCESS | 1182 | Cycle 1(1): loaded http://localhost:44148/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44148/tests/dromaeo/cssquery-mootools.html) 10:38:51 INFO - PROCESS | 1182 | RSS: Main: 246231040 10:38:51 INFO - PROCESS | 1182 | 10:41:53 INFO - PROCESS | 1182 | Cycle 1(1): loaded http://localhost:44148/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44148/tests/dromaeo/cssquery-prototype.html) 10:41:54 INFO - PROCESS | 1182 | RSS: Main: 207978496 10:41:54 INFO - PROCESS | 1182 | 10:44:56 INFO - PROCESS | 1182 | Cycle 1(1): loaded http://localhost:44148/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44148/tests/dromaeo/cssquery-yui.html) 10:44:57 INFO - PROCESS | 1182 | RSS: Main: 208912384 10:44:57 INFO - PROCESS | 1182 | 10:47:59 INFO - PROCESS | 1182 | Cycle 1(1): loaded http://localhost:44148/tests/dromaeo/cssquery-yui.html (next: http://localhost:44148/tests/dromaeo/cssquery-dojo.html) 10:48:00 INFO - PROCESS | 1182 | RSS: Main: 277458944 10:48:00 INFO - PROCESS | 1182 | 10:48:00 INFO - PROCESS | 1182 | __start_tp_report 10:48:00 INFO - PROCESS | 1182 | _x_x_mozilla_page_load 10:48:00 INFO - PROCESS | 1182 | _x_x_mozilla_page_load_details 10:48:00 INFO - PROCESS | 1182 | |i|pagename|runs| 10:48:00 INFO - PROCESS | 1182 | |0;dojo.html;2629.5003949249644;2662.786977041837;2687.34160130768;2688.166668332817;2709.7290270972903;4626.097910907366;4681.953180468195;4685.086408150412;4692.178868697977;4718.551737584924;4636.675432719711;4707.764611769407;4734.857954261369;4752.168370535152;4760.880977975544;4331.3405986155185;4334.176506463762;4355.063661312817;4389.824407023715;4471.932921006188;4262;4385;4391.121775644868;4439.178751930887;4470;4324.17840610283;4336.3929049933195;4403.735775853459;4413.271810151321;4424.469063712343;4350.108227813291;4364.738115713068;4375.0812329410865;4375.78121093944;4411.205982923073;4352.825886964518;4363.323684828857;4374.956250437487;4399.670024748157;4411.42651455312;4487.39420178275;4591.242444996572;4643.233866412038;4686.2267725825195;4695.413073365829;5084.084864724348;5090.949090509084;5097.388313402378;5120.3855537335385;5150.0472412603785;4981.950180498185;5113.463086375914;5120.231965205212;5125.923111153335;5127;4771.021940502189;4798.95201047992;4820.6143508519235;4865.854024379239;4866.902661946741;5158.92261616076;5160.767765450564;5167.793288268427;5169.560587350117;5221.295125158055;4895.069936712013;4963.255511673278;4970.329005584272;4970.90058198834;5026.89946201074;5089.9745501272255;5097.592192624581;5124.256982737482;5129.307543481582;5134.922976155361;5035.1188542005;5041.344625198701;5048;5051.015052064886;5100.464451232641;4935.555799978019;5030;5038.798448062036;5041.571466425322;5046.949530504648;4237.173751118502;4239.173361194599;4246.363045543193;4307.483102027777;4321.092570560155;3758.473813666089;3758.5489741231227;3765.6234376562675;3804.752691075071;3807.6573108420375;4389.122175564899;4395.450568678915;4400.22995975703;4402.427684401007;4438.955610443919;4979.925301120486;5101.20931255656;5148.176291793295;5187.714675692798;5190.195519694454;4331.805068771912;4332.761698106571;4348.021695118637;4354.085642015212;4392.38506609075;4487.080148569536;4526.23054080807;4534.79593418297;4535.659825513099;4570.680052396367;4810.302506136591;4852.0295940811275;4852.660313778002;4907.312976183409;4907.509249075064;5068.493150684902;5111.795528178831;5111.948880511296;5118.616103792156;5169.638125331191;4743.620510359094;4783.354247176587;4843.200871856105;4864.878378040577;4909.68087074339;5039.2944987702485;5043.117454445531;5068.645194836474;5108.61685373591;5110.054639891632;5100.260462232881;5131.897362052813;5135.127028405254;5143.228515722672;5189.870253243548;4801.351817504732;4885.95114048855;4945.357103576512;4968.254761785616;4977.850664480072;4851.320815085962;4854.320395144612;4863.2461968394955;4889.926651100308;4915.188993816123;4804.73573953422;4807.4471435783935;4807.543283388072;4814.6870453420415;4856.295837103671;4830.130576496264;4918.508149185053;4939.629527785359;4991.575716064175;5006.524380183877;4872.074305881871;4890.315355850113;4897.730624815669;4924;4948.331975183304 10:48:00 INFO - PROCESS | 1182 | |1;ext.html;548.4405905975907;552.1248820619321;558.2630927176127;569.2798609758655;582.9533637309015;26616.733832661666;33744;34094.48858267128;34100.31799364014;34197.82901085491;37019;37556.81221593888;37605.05987350311;37654.05864853373;37755.24489510208;7749.535027898316;7959.840803183933;7965.402594805384;7972.3622110231045;7975.96012019942;7728.188540203282;7844.607769611496;7848.45060845741;7854.921450785476;8014.438989270753;7980.840383192332;8081.272685458308;8102.918970810305;8103.675852965875;8107.716229931953;7957.562334071624;8091;8099.514029158269;8100.554469504175;8115.634796434204;7879.4484386093;7905.56519391439;7917.683292668286;7927.5243485391065;7943.046834379854;37871;38380;38387.8080609598;38394.42408363877;38403.807980959915;2943.970560294391;3017.9396412071856;3029.166979080748;3050.740687041604;3091.335362896988;28086.157415277576;28305.15084547467;28475.715242847513;28782.280442988882;28957.71042289571;3479.9130021749406;3485.3203625293077;3485.5643044619424;3515.753897227195;3527.3827080260853;237699;237737;237895;238338;239166;53031.469685302654;53050;53195.202071968175;53402.46597534053;53522.7323863386;57135;57588.424115759146;61424.38575614276;62032.68983655143;62180.37819621746;13468.461261549624;13781.448742050407;13836.584902452943;13837.238951857744;13837.86162138386;10235.334703244265;10280.331778434378;10310.07209351162;10323.380597164194;10334.638287659896;19192.232310707695;19203.423897283104;19209.135588898534;19313.4205973821;19393.4181974541;7465.776026719099;7841.863903847586;7876.803079923047;7898.328642065374;7952.32405245549;825.1995564302617;967.2213867836459;978.6966040527459;1004.4977511244377;1035.171862509989;26082.13096559377;27287.863560682068;27463.725362746118;27496.312592185357;27646;915.6337465013914;974.9512524373753;975.4683697384942;1001.2690735762934;1010.2019404670375;12384;12711.555095571795;12871.549495767604;13001.934990325177;13077.738445231042;306834;313614;313963;314624;315883.88812782883;46399;46894.296585551245;46999.5300047002;47047.29429058567;47058.294125588145;966.4732720667254;1152.0150271517732;1231.5689508672071;1236.8330275412884;1265.8797414245632;23653.408664783517;24449;24642.260732177347;24837.50324993526;24956.625650615617;32360.83819580981;32766.508502372006;33034;33411.49882751712;33462.66537334595;145742.2712886429;152889.23555382152;153422;153673.23163384112;153931;26425.60361594539;29495.852520738117;30496.23759405944;30570.388592228475;31158.844205778827;34270;34401.483977740856;35067.82266127545;35316;37901.431478527295;31568.526472103396;31800.36399272048;32402.513962291057;32426.83786581052;32871.17822054468;32184.678153219105;32383.51424728678;32873.50689739608;32904.506432404014;33048;31631.84184079065;32242.677573224904;32410.35179296448;32749;32813.83593082115;28002.719972800012;28908.7109128906;29538.704612954454;29697.851510743174;29923.70076299209;23487.412814679086;23838.04647814068;24162.87918560396;24199;24215.51568968646 10:48:00 INFO - PROCESS | 1182 | |2;jquery.html;354.1730060309178;356.20743844945;364.62443683006506;366.83492428407226;368.34802399752436;15498.302576384061;15587.751695461608;17431.389901353454;17468.301267949268;17476.12619369033;16657.66684666309;16952.83047169531;17200.741988870177;17204.913975430107;17208.39770608029;4650.000249946261;5037.0933232018315;5211.114110601188;5214.973925130369;5215.295935048777;5137.974310128444;5151.4333423323405;5165.457626949173;5180.171172612383;5192.1952097424955;4996.075725990685;5099.974500127512;5156.252343410203;5168.121419358718;5172.715500647463;5142.07442660321;5154.123798954187;5155.58755299577;5157.226416037587;5162.277281180638;4615.284630882219;4615.769211539409;4617.12274667812;4620.1221767864;4998.45017048128;11859.881401185963;11864.584739534075;11996.520139194421;12013.399330033464;12014.819777703342;1916.4059141666128;1941.3011315926256;1991.4722598511405;1994.8703334283225;2269.965950510744;8768.07935166811;8814.427062240933;8939.240164586017;8985.550722463917;9142.77143071422;1796.9550761231073;1798.4424828303138;1821.225978958937;1882.745829313039;1886.528367908023;59287;60392;60690;61481.38518614846;62208.02335813124;10319.638812641522;10447.947760261302;10456.274714672147;10493;10657.84013239802;13403.731925361439;13487.05590608648;13489.460421583026;13503.932480337535;13514.391852366667;7208.675609597476;7436.925630743732;7496.062992125984;7566.054243219598;7566.886496702554;7069.6111713856235;7106.751263705849;7188.928110718931;7208.2791720828545;7237.782866514013;4422.646188304992;4436.378906953029;4452.263617189299;4472.9776351118035;4569.748663823521;1833.4591295567839;1851.3427733154806;1856.071964017991;1875.5311172206948;1893.7916829148783;858.219020691168;868.1492137704959;871.2333146830748;873.5675840459013;912.5847739278612;15821.68356632861;16194.109323987059;16338.428155014755;16536.090515021788;16762;869.2437579306044;870;879.402006635494;882.2677177942293;922.7739203895088;9401.90598094024;9939;9953.552090155961;10045.24796683144;10454.477276136162;408132;426235;440401;440883;441408;46739.29891051637;47240.291395629094;64610;73927.26072739204;74761;941.3222479814523;951.0869565217331;959.6353385713384;974.5176137811828;977.726236653738;12176.512939482676;15061.698766024838;15166.165860877758;15379.538613841603;15465.149416782186;34928.47607285842;35353.29293414169;35542.64457355393;35738.8213058933;35857.64142358543;43871.80640967875;45334.77332613316;46002;46155;46444.7677761609;7175.497715159889;7216.855662886608;7227.27727227273;7292.927070729224;7311.378532824557;9319.767005824908;10972.670819875417;11217;11255;11452.541898324307;9428.245740340619;10028.247881408777;10338;10439.947800261254;10638.574457021632;4966.503349665005;6623.774601698701;6914.8617027660175;9270.53647317645;9985.700428987142;10182.389056656624;10226.956556301766;10341.896581034394;10428.374297542172;10710.946445267724;7324.340809327186;7325.560466372035;7385.48301618903;7472.36484898768;7685.423593230642;9570.617175313188;10128.189744820544;10182.134518566005;10259.589616415558;10390 10:48:00 INFO - PROCESS | 1182 | |3;mootools.html;1155.324135380802;1430.3134495442187;1440.0567628203528;1586.8413158684125;1782.9108544572775;7113.1819840718335;7323.670434830432;7363.595002274879;7365.33711965923;7375.04124463819;7307.780766576998;7523.51097178683;7526.548407095578;7528.698852045912;7539.359154471863;1942.2910637617238;1993.4019794061796;2239.1267405711706;2307.538492301542;2336.158982766203;2313.791758741713;2322.3497420722224;2323.7908588227056;2325.058351367699;2326.174208156097;2232.598132336179;2249.3139592424304;2259.8418110732255;2317.1889838556453;2317.6986991691056;2237.7650346713685;2270.2621647964397;2275.7610450902584;2275.943101422461;2280.6579013148075;2269.217120093565;2289.3933107726466;2291.026313816638;2295.127851416468;2296.4603318220206;7699.384049276045;7817.413693972918;7826.921730782677;7827.25641064098;7831.765047048598;4779.784909679072;4866.3673722416215;4907.411110666707;4909.729964851967;4909.950900491021;3006.744426723731;3014.110837303001;3108.6269647642202;3135.435621588113;3159.368126374711;985.8718366612367;992.9304948653597;993.6671215142936;1015.8120747661707;1019.6991887393162;10618.73453163677;10634.734131646694;10649.733756656067;10652.307600005975;10652.786944261148;4447;4494.16857881293;4547.454305483363;4576.633869290449;4579.496255411902;8990.235829954527;9027.50348730826;9042.00537940826;9050.09499050103;9059.773505662411;4826.927596086061;4848.612111031109;4855.32025516428;4855.854324370274;4857.417109946829;3637.6907962823457;3752.7560708553856;4223.915521689549;4333.848315308949;4341.08837144197;3756.6055564165918;3809.657130858236;3826.521684789401;3844.3272427325105;3872.1287710264965;1232.796588562895;1245.9501619935281;1247.875212478745;1256.5413624027165;1257.1765493601706;945.6595625574788;993.9662750739295;1175.5709166154463;1182.3201659046083;1188.756304957499;7054.329838665319;7100.573965562083;7160.498765086394;7191.208967013625;7195.748148814766;1036.4506811389974;1045.414567842011;1052.8526006359116;1073.8603981482356;1094.7372630568607;5590.2453168821685;5603.075492543685;5625.521830644441;5639.6334238274385;5656.519195868315;8773.07882672323;8794.692185773467;9065.68270110543;9169.495677737788;9169.816603667889;8816.074312197255;8892.244159246407;8962.910370896208;9040.728778136667;9063.637454501877;6981.581105133709;6996.545224560387;7211.062561867028;7227.5302105364035;7256.2018177999325;7047.471439641945;7070.646467676493;7097.432205423657;7113.430925525842;7152.499325047404;8284.46151000183;8337.583120843812;8476.788080298042;8487.490750554987;8579.227869491775;8731.56342182901;8736.825263494567;8748.431351962103;8760.60577274037;8762.780930476789;5597.972010139923;6362.172917520693;6384.138141350858;6524.4454221389815;6619.073329733745;7053.153621565445;7077.115360579927;7104.325089116525;7137.607431591105;7146.67839947214;6291.685415729286;6432.163818703539;6439;6482.416582507597;6533.901991470227;6319.399657032574;6341.239051313872;6402.679866006774;6455.7740479083;6499.155109835691;6838.692258848463;6874.072000279898;6886.69009894566;6899.793006209822;6902.447804175554;6349.587276826992;6375.6174629522375;6423.132877061536;6428.357164283534;6433.646149461637;6385.393387628168;6392;6424.550281480251;6440.516961228021;6442.742290308335 10:48:00 INFO - PROCESS | 1182 | |4;prototype.html;324.14264271003196;326.5037143541816;326.84801567271217;329.09827073817746;332.46473178183106;5394.649347792396;5399.217113518543;5423.349198096224;5431.402545719968;5482.1228603423415;5325.893482130365;5363.490468405495;5373.462653734625;5374.543163831079;5383.246345511622;3987.9601203987877;4083.9387409188885;4163.937540936889;4204.054087830229;4212.136512015038;4174.582541745832;4186.225548273564;4190.72760270583;4198.055437526547;4203.453551038361;4154.584541545836;4155.62599366057;4162.1675664867;4163.250614889319;4171.207470580595;3977.741446805963;4078.714489985717;4139.544650088488;4141.482314710661;4160.875173744793;3649.6532829381167;3649.835757390924;3652.5616925969052;3662.176010397666;3670.5595328560744;5146.871328216787;5151.381834179922;5159.896802063938;5163.793448262065;5164.948350516484;4819.855404337841;4845.757712114416;4846.61227101831;4848.321235027099;4854.053459575384;5650.830475085754;5659.547236221134;5659.6321239119325;5664.037113690682;5666.5183459406;4064.5325787534516;4065.390191471303;4066.7763273019973;4070.409790580349;4071.1654110907193;5803.5357171426185;5916.0534314509905;5928.258967629046;5990.341062483167;6017.217761690996;4117.155983023473;4178.435911152016;4185.979070104691;4188.350805625133;4191.434156388848;4244;4246.936295955563;4248.63886569645;4253.957460425418;4271.893202669959;4833.975830120898;4836.322914791932;4844.346013288232;4846.345743324606;4852.126617208936;5691.4877661010705;5693.060644993612;5694.202811606378;5702.372738998707;5703.116017017369;1466.2229018620149;1485.2054151029147;1507.4045751928147;1507.9623009424633;1508;987.6839411388287;1025.9384436933808;1029.7374169586708;1050.2228351020342;1053.578568572577;4928.186849169919;4944.283078953532;4977.477364876709;4977.552020318117;4978.975105124524;5840.065589505659;5846.795362162304;5894.086416605433;5894.941050589525;5896.587238893237;4931.753412329369;4965.0566392385335;4966.230234313687;4972.204447288416;4975.477574854661;3116.9064928052194;3144.276816332256;3148.165736079941;3175.17445464181;3177.158053115926;5509.1268968550885;5518.558515318765;5536.723163841792;5538.723063846872;5542.8337149885565;5890.764369425261;6127.601705889103;6171.753129874754;6189.319174890758;6199.938000620026;5616.803411880564;5632.746526406321;5637.267155269788;5643.774249030075;5650.830475085754;5944.6730429826775;5960.105984102419;5962.701864906824;5967.403259673998;5968.701564921824;5830.883382332415;5836.212111365081;5836.854078648068;5839.15332276809;5844.6785426801935;5422.213779001943;5624.353199382123;5625.493705566519;5632.070708333079;5634.32388113429;4012.378081397388;4061;4088.0393107619093;4110.301248787653;4118.032262418389;5950.054722912186;5957.791477298274;5962.344142144448;5963.254593175853;5973.283206015306;5705.62913410627;5715.971420142872;5717.485426311652;5729.627574207663;5742.913856292075;5697.54419646419;5706.144078388275;5712.971435142797;5716.085426331767;5729.455701708331;5417.106177480671;5615.522680572197;5624.212610234652;5626.324841019104;5657.773689052557;5743.9138412923;5766.019776637898;5770.990076736638;5772.134179873053;5776.480116789509;5616.157576363578;5627.127795191752;5634.943650563606;5643.746031428514;5645.661260324394 10:48:00 INFO - PROCESS | 1182 | |5;yui.html;651.7914267434421;661.0150875195957;715.0632671200724;725.7205975699358;747.3759410891902;12122.393880305983;12548.937255313711;12576.937115314433;12593.118481706273;12619.55831545896;12132.939335303334;12186.939065304683;12194.390280485984;12198.207116537418;12210.816837747441;643.9742410303583;784.4704824243641;796.9123396426388;811.5779794506852;818.2676504528444;809.7692157735047;809.7854068671807;816.5957850863831;816.7958010497375;817.7015389382863;845.023997283139;852.8166444214493;854.1757204297851;854.9529775862325;855.7817756472091;668.7993601919429;828.9088200297963;833.6207025803245;835.1940377535647;835.7659855240512;623.2552100240215;623.6943897490243;623.8003838771594;626.4017862940881;627.5481653209682;12348.259104453762;12397.318147501885;12402.13185077045;12427.3786310685;12453.937730311382;11646.301221926711;12234.853736309356;12390.194637348544;12660.68348291291;12778.666772683484;9821.214302855755;9867.851982220272;9976.351537150062;10051.246156538216;10062.899371006342;3356.0770788033487;3364.108511244522;3381.070205693429;3506.5266189064405;3513.1744040150543;43444.348334775;43541.56458435438;43684.56315436837;43837.34243986343;43942.56057439448;10001.599936002478;10059.597616095421;10163.085322320878;10217.948910255402;10230.64192753265;16929;17093.145342733063;17120.14399280031;17127.00277451441;17128.40050598223;6691.096701945273;6746.696398661974;6839.247682754893;6863.313668633096;6883.174019117738;3727.813609319523;3764.1154328732728;3772.2078363543965;3803.790791506494;3879.0302424393903;2760.323720688444;2760.3513174403997;2768.197222805404;2778.097118436516;2790.6651201855907;506.30636028641;511.411876342202;515.2014377714528;519.057909893542;524.0802391802363;562.2044806598699;566.2497191221648;584.4622946888873;585.771549095853;586.7359688140353;7592.620368981639;7763.340116090083;7804.531728096219;8093.55485448306;8159.224873636995;482.3753239554715;552.5082676417991;564.610418811019;569.8091139468324;573.86801035762;3531.646835316499;3588.8743893963588;3616.764910280823;3658.6158453362546;3726.0312318796764;49251.75374123178;49740.502594974314;49822.75088624534;49886.50113498891;50014.49985500171;43526.34710479345;45510.54489455063;45650.77174614172;46226.30660540095;46607.53392466032;39893.800530997156;41111;41192.58807411948;41260.999999999396;41300.793496032325;8317.500949943023;8364.6235919385;8401.663933442594;8473;8565.100664430145;29611.555826663047;29614;29616.703832961393;29741.85129074341;30991.535126972663;36801;38929.80535097307;39381.80309098436;39536.802315988236;39610.80194599008;9559.522023898639;9595.616175352907;9685.467299298325;9687.854682179914;9768.120869121529;10635.89364106349;11184.273022253528;11194.104471642411;11233.494492747683;11566;10446.791064178522;10617.522211500347;10645.467726613793;10655.520501577292;10955.945220273848;10452.790944181226;10553.366797992145;10647.94676026615;10675.839862402225;10968.23222374458;10486.423246721504;10554.2084343673;10655.467226638482;10676;10739.838902416313;8872.068432814462;8951.597178127131;9083.18251357381;9205.447673139633;9350.906490935276;8810.647574096964;8866.246369058445;8877.422967507091;9008.32437567172;9324.300677449082 10:48:00 INFO - PROCESS | 1182 | __end_tp_report 10:48:00 INFO - PROCESS | 1182 | __start_cc_report 10:48:00 INFO - PROCESS | 1182 | _x_x_mozilla_cycle_collect,1084 10:48:00 INFO - PROCESS | 1182 | __end_cc_report 10:48:00 INFO - PROCESS | 1182 | __startTimestamp1458236880090__endTimestamp 10:48:00 INFO - PROCESS | 1182 | 10:48:00 INFO - PROCESS | 1182 | ------- Summary: start ------- 10:48:00 INFO - PROCESS | 1182 | Number of tests: 6 10:48:00 INFO - PROCESS | 1182 | 10:48:00 INFO - PROCESS | 1182 | [#0] dojo.html Cycles:165 Average:4693.66 Median:4843.20 stddev:490.58 (10.1%) stddev-sans-first:464.60 10:48:00 INFO - PROCESS | 1182 | Values: 2629.5 2662.8 2687.3 2688.2 2709.7 4626.1 4682.0 4685.1 4692.2 4718.6 4636.7 4707.8 4734.9 4752.2 4760.9 4331.3 4334.2 4355.1 4389.8 4471.9 4262.0 4385.0 4391.1 4439.2 4470.0 4324.2 4336.4 4403.7 4413.3 4424.5 4350.1 4364.7 4375.1 4375.8 4411.2 4352.8 4363.3 4375.0 4399.7 4411.4 4487.4 4591.2 4643.2 4686.2 4695.4 5084.1 5090.9 5097.4 5120.4 5150.0 4982.0 5113.5 5120.2 5125.9 5127.0 4771.0 4799.0 4820.6 4865.9 4866.9 5158.9 5160.8 5167.8 5169.6 5221.3 4895.1 4963.3 4970.3 4970.9 5026.9 5090.0 5097.6 5124.3 5129.3 5134.9 5035.1 5041.3 5048.0 5051.0 5100.5 4935.6 5030.0 5038.8 5041.6 5046.9 4237.2 4239.2 4246.4 4307.5 4321.1 3758.5 3758.5 3765.6 3804.8 3807.7 4389.1 4395.5 4400.2 4402.4 4439.0 4979.9 5101.2 5148.2 5187.7 5190.2 4331.8 4332.8 4348.0 4354.1 4392.4 4487.1 4526.2 4534.8 4535.7 4570.7 4810.3 4852.0 4852.7 4907.3 4907.5 5068.5 5111.8 5111.9 5118.6 5169.6 4743.6 4783.4 4843.2 4864.9 4909.7 5039.3 5043.1 5068.6 5108.6 5110.1 5100.3 5131.9 5135.1 5143.2 5189.9 4801.4 4886.0 4945.4 4968.3 4977.9 4851.3 4854.3 4863.2 4889.9 4915.2 4804.7 4807.4 4807.5 4814.7 4856.3 4830.1 4918.5 4939.6 4991.6 5006.5 4872.1 4890.3 4897.7 4924.0 4948.3 10:48:00 INFO - PROCESS | 1182 | 10:48:00 INFO - PROCESS | 1182 | [#1] ext.html Cycles:180 Average:39286.37 Median:32790.17 stddev:63862.30 (194.8%) stddev-sans-first:63975.22 10:48:00 INFO - PROCESS | 1182 | Values: 548.4 552.1 558.3 569.3 583.0 26616.7 33744.0 34094.5 34100.3 34197.8 37019.0 37556.8 37605.1 37654.1 37755.2 7749.5 7959.8 7965.4 7972.4 7976.0 7728.2 7844.6 7848.5 7854.9 8014.4 7980.8 8081.3 8102.9 8103.7 8107.7 7957.6 8091.0 8099.5 8100.6 8115.6 7879.4 7905.6 7917.7 7927.5 7943.0 37871.0 38380.0 38387.8 38394.4 38403.8 2944.0 3017.9 3029.2 3050.7 3091.3 28086.2 28305.2 28475.7 28782.3 28957.7 3479.9 3485.3 3485.6 3515.8 3527.4 237699.0 237737.0 237895.0 238338.0 239166.0 53031.5 53050.0 53195.2 53402.5 53522.7 57135.0 57588.4 61424.4 62032.7 62180.4 13468.5 13781.4 13836.6 13837.2 13837.9 10235.3 10280.3 10310.1 10323.4 10334.6 19192.2 19203.4 19209.1 19313.4 19393.4 7465.8 7841.9 7876.8 7898.3 7952.3 825.2 967.2 978.7 1004.5 1035.2 26082.1 27287.9 27463.7 27496.3 27646.0 915.6 975.0 975.5 1001.3 1010.2 12384.0 12711.6 12871.5 13001.9 13077.7 306834.0 313614.0 313963.0 314624.0 315883.9 46399.0 46894.3 46999.5 47047.3 47058.3 966.5 1152.0 1231.6 1236.8 1265.9 23653.4 24449.0 24642.3 24837.5 24956.6 32360.8 32766.5 33034.0 33411.5 33462.7 145742.3 152889.2 153422.0 153673.2 153931.0 26425.6 29495.9 30496.2 30570.4 31158.8 34270.0 34401.5 35067.8 35316.0 37901.4 31568.5 31800.4 32402.5 32426.8 32871.2 32184.7 32383.5 32873.5 32904.5 33048.0 31631.8 32242.7 32410.4 32749.0 32813.8 28002.7 28908.7 29538.7 29697.9 29923.7 23487.4 23838.0 24162.9 24199.0 24215.5 10:48:00 INFO - PROCESS | 1182 | 10:48:00 INFO - PROCESS | 1182 | [#2] jquery.html Cycles:180 Average:24196.26 Median:25285.87 stddev:70652.49 (279.4%) stddev-sans-first:70828.01 10:48:00 INFO - PROCESS | 1182 | Values: 354.2 356.2 364.6 366.8 368.3 15498.3 15587.8 17431.4 17468.3 17476.1 16657.7 16952.8 17200.7 17204.9 17208.4 4650.0 5037.1 5211.1 5215.0 5215.3 5138.0 5151.4 5165.5 5180.2 5192.2 4996.1 5100.0 5156.3 5168.1 5172.7 5142.1 5154.1 5155.6 5157.2 5162.3 4615.3 4615.8 4617.1 4620.1 4998.5 11859.9 11864.6 11996.5 12013.4 12014.8 1916.4 1941.3 1991.5 1994.9 2270.0 8768.1 8814.4 8939.2 8985.6 9142.8 1797.0 1798.4 1821.2 1882.7 1886.5 59287.0 60392.0 60690.0 61481.4 62208.0 10319.6 10447.9 10456.3 10493.0 10657.8 13403.7 13487.1 13489.5 13503.9 13514.4 7208.7 7436.9 7496.1 7566.1 7566.9 7069.6 7106.8 7188.9 7208.3 7237.8 4422.6 4436.4 4452.3 4473.0 4569.7 1833.5 1851.3 1856.1 1875.5 1893.8 858.2 868.1 871.2 873.6 912.6 15821.7 16194.1 16338.4 16536.1 16762.0 869.2 870.0 879.4 882.3 922.8 9401.9 9939.0 9953.6 10045.2 10454.5 408132.0 426235.0 440401.0 440883.0 441408.0 46739.3 47240.3 64610.0 73927.3 74761.0 941.3 951.1 959.6 974.5 977.7 12176.5 15061.7 15166.2 15379.5 15465.1 34928.5 35353.3 35542.6 35738.8 35857.6 43871.8 45334.8 46002.0 46155.0 46444.8 7175.5 7216.9 7227.3 7292.9 7311.4 9319.8 10972.7 11217.0 11255.0 11452.5 9428.2 10028.2 10338.0 10439.9 10638.6 4966.5 6623.8 6914.9 9270.5 9985.7 10182.4 10227.0 10341.9 10428.4 10710.9 7324.3 7325.6 7385.5 7472.4 7685.4 9570.6 10128.2 10182.1 10259.6 10390.0 10:48:00 INFO - PROCESS | 1182 | 10:48:00 INFO - PROCESS | 1182 | [#3] mootools.html Cycles:180 Average:5354.34 Median:6368.90 stddev:2742.31 (43.1%) stddev-sans-first:2731.83 10:48:00 INFO - PROCESS | 1182 | Values: 1155.3 1430.3 1440.1 1586.8 1782.9 7113.2 7323.7 7363.6 7365.3 7375.0 7307.8 7523.5 7526.5 7528.7 7539.4 1942.3 1993.4 2239.1 2307.5 2336.2 2313.8 2322.3 2323.8 2325.1 2326.2 2232.6 2249.3 2259.8 2317.2 2317.7 2237.8 2270.3 2275.8 2275.9 2280.7 2269.2 2289.4 2291.0 2295.1 2296.5 7699.4 7817.4 7826.9 7827.3 7831.8 4779.8 4866.4 4907.4 4909.7 4910.0 3006.7 3014.1 3108.6 3135.4 3159.4 985.9 992.9 993.7 1015.8 1019.7 10618.7 10634.7 10649.7 10652.3 10652.8 4447.0 4494.2 4547.5 4576.6 4579.5 8990.2 9027.5 9042.0 9050.1 9059.8 4826.9 4848.6 4855.3 4855.9 4857.4 3637.7 3752.8 4223.9 4333.8 4341.1 3756.6 3809.7 3826.5 3844.3 3872.1 1232.8 1246.0 1247.9 1256.5 1257.2 945.7 994.0 1175.6 1182.3 1188.8 7054.3 7100.6 7160.5 7191.2 7195.7 1036.5 1045.4 1052.9 1073.9 1094.7 5590.2 5603.1 5625.5 5639.6 5656.5 8773.1 8794.7 9065.7 9169.5 9169.8 8816.1 8892.2 8962.9 9040.7 9063.6 6981.6 6996.5 7211.1 7227.5 7256.2 7047.5 7070.6 7097.4 7113.4 7152.5 8284.5 8337.6 8476.8 8487.5 8579.2 8731.6 8736.8 8748.4 8760.6 8762.8 5598.0 6362.2 6384.1 6524.4 6619.1 7053.2 7077.1 7104.3 7137.6 7146.7 6291.7 6432.2 6439.0 6482.4 6533.9 6319.4 6341.2 6402.7 6455.8 6499.2 6838.7 6874.1 6886.7 6899.8 6902.4 6349.6 6375.6 6423.1 6428.4 6433.6 6385.4 6392.0 6424.6 6440.5 6442.7 10:48:00 INFO - PROCESS | 1182 | 10:48:00 INFO - PROCESS | 1182 | [#4] prototype.html Cycles:180 Average:4738.46 Median:5368.48 stddev:1385.35 (25.8%) stddev-sans-first:1349.04 10:48:00 INFO - PROCESS | 1182 | Values: 324.1 326.5 326.8 329.1 332.5 5394.6 5399.2 5423.3 5431.4 5482.1 5325.9 5363.5 5373.5 5374.5 5383.2 3988.0 4083.9 4163.9 4204.1 4212.1 4174.6 4186.2 4190.7 4198.1 4203.5 4154.6 4155.6 4162.2 4163.3 4171.2 3977.7 4078.7 4139.5 4141.5 4160.9 3649.7 3649.8 3652.6 3662.2 3670.6 5146.9 5151.4 5159.9 5163.8 5164.9 4819.9 4845.8 4846.6 4848.3 4854.1 5650.8 5659.5 5659.6 5664.0 5666.5 4064.5 4065.4 4066.8 4070.4 4071.2 5803.5 5916.1 5928.3 5990.3 6017.2 4117.2 4178.4 4186.0 4188.4 4191.4 4244.0 4246.9 4248.6 4254.0 4271.9 4834.0 4836.3 4844.3 4846.3 4852.1 5691.5 5693.1 5694.2 5702.4 5703.1 1466.2 1485.2 1507.4 1508.0 1508.0 987.7 1025.9 1029.7 1050.2 1053.6 4928.2 4944.3 4977.5 4977.6 4979.0 5840.1 5846.8 5894.1 5894.9 5896.6 4931.8 4965.1 4966.2 4972.2 4975.5 3116.9 3144.3 3148.2 3175.2 3177.2 5509.1 5518.6 5536.7 5538.7 5542.8 5890.8 6127.6 6171.8 6189.3 6199.9 5616.8 5632.7 5637.3 5643.8 5650.8 5944.7 5960.1 5962.7 5967.4 5968.7 5830.9 5836.2 5836.9 5839.2 5844.7 5422.2 5624.4 5625.5 5632.1 5634.3 4012.4 4061.0 4088.0 4110.3 4118.0 5950.1 5957.8 5962.3 5963.3 5973.3 5705.6 5716.0 5717.5 5729.6 5742.9 5697.5 5706.1 5713.0 5716.1 5729.5 5417.1 5615.5 5624.2 5626.3 5657.8 5743.9 5766.0 5771.0 5772.1 5776.5 5616.2 5627.1 5634.9 5643.7 5645.7 10:48:00 INFO - PROCESS | 1182 | 10:48:00 INFO - PROCESS | 1182 | [#5] yui.html Cycles:180 Average:12472.65 Median:43760.95 stddev:13977.95 (31.9%) stddev-sans-first:13988.97 10:48:00 INFO - PROCESS | 1182 | Values: 651.8 661.0 715.1 725.7 747.4 12122.4 12548.9 12576.9 12593.1 12619.6 12132.9 12186.9 12194.4 12198.2 12210.8 644.0 784.5 796.9 811.6 818.3 809.8 809.8 816.6 816.8 817.7 845.0 852.8 854.2 855.0 855.8 668.8 828.9 833.6 835.2 835.8 623.3 623.7 623.8 626.4 627.5 12348.3 12397.3 12402.1 12427.4 12453.9 11646.3 12234.9 12390.2 12660.7 12778.7 9821.2 9867.9 9976.4 10051.2 10062.9 3356.1 3364.1 3381.1 3506.5 3513.2 43444.3 43541.6 43684.6 43837.3 43942.6 10001.6 10059.6 10163.1 10217.9 10230.6 16929.0 17093.1 17120.1 17127.0 17128.4 6691.1 6746.7 6839.2 6863.3 6883.2 3727.8 3764.1 3772.2 3803.8 3879.0 2760.3 2760.4 2768.2 2778.1 2790.7 506.3 511.4 515.2 519.1 524.1 562.2 566.2 584.5 585.8 586.7 7592.6 7763.3 7804.5 8093.6 8159.2 482.4 552.5 564.6 569.8 573.9 3531.6 3588.9 3616.8 3658.6 3726.0 49251.8 49740.5 49822.8 49886.5 50014.5 43526.3 45510.5 45650.8 46226.3 46607.5 39893.8 41111.0 41192.6 41261.0 41300.8 8317.5 8364.6 8401.7 8473.0 8565.1 29611.6 29614.0 29616.7 29741.9 30991.5 36801.0 38929.8 39381.8 39536.8 39610.8 9559.5 9595.6 9685.5 9687.9 9768.1 10635.9 11184.3 11194.1 11233.5 11566.0 10446.8 10617.5 10645.5 10655.5 10955.9 10452.8 10553.4 10647.9 10675.8 10968.2 10486.4 10554.2 10655.5 10676.0 10739.8 8872.1 8951.6 9083.2 9205.4 9350.9 8810.6 8866.2 8877.4 9008.3 9324.3 10:48:00 INFO - PROCESS | 1182 | -------- Summary: end -------- 10:48:00 INFO - PROCESS | 1182 | 10:48:00 INFO - TEST-INFO | 1182: exit 0 10:48:00 INFO - TEST-OK | dromaeo_css | took 1116708ms 10:48:00 INFO - TEST-START | kraken 10:48:00 INFO - operating with platform_type : linux_ 10:48:00 INFO - Initialising browser for kraken test... 10:48:00 INFO - TEST-INFO | started process 1355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptfyFq7/profile http://localhost:44148/getInfo.html) 10:48:05 INFO - PROCESS | 1355 | __metrics Screen width/height:1600/1200 10:48:05 INFO - PROCESS | 1355 | colorDepth:24 10:48:05 INFO - PROCESS | 1355 | Browser inner width/height: 1024/697 10:48:05 INFO - PROCESS | 1355 | __metrics 10:48:06 ERROR - PROCESS | 1355 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:48:07 INFO - TEST-INFO | 1355: exit 0 10:48:07 INFO - Browser initialized. 10:48:07 INFO - Running cycle 1/1 for kraken test... 10:48:07 INFO - TEST-INFO | started process 1439 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptfyFq7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:48:19 INFO - PROCESS | 1439 | RSS: Main: 154804224 10:48:19 INFO - PROCESS | 1439 | 10:48:21 INFO - PROCESS | 1439 | Cycle 1(1): loaded http://localhost:44148/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44148/tests/kraken/driver.html?testName=audio-beat-detection) 10:48:22 INFO - PROCESS | 1439 | RSS: Main: 198062080 10:48:22 INFO - PROCESS | 1439 | 10:48:25 INFO - PROCESS | 1439 | Cycle 1(1): loaded http://localhost:44148/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44148/tests/kraken/driver.html?testName=audio-dft) 10:48:25 INFO - PROCESS | 1439 | RSS: Main: 187437056 10:48:25 INFO - PROCESS | 1439 | 10:48:28 INFO - PROCESS | 1439 | Cycle 1(1): loaded http://localhost:44148/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44148/tests/kraken/driver.html?testName=audio-fft) 10:48:29 INFO - PROCESS | 1439 | RSS: Main: 172204032 10:48:29 INFO - PROCESS | 1439 | 10:48:31 INFO - PROCESS | 1439 | Cycle 1(1): loaded http://localhost:44148/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44148/tests/kraken/driver.html?testName=audio-oscillator) 10:48:31 INFO - PROCESS | 1439 | RSS: Main: 175173632 10:48:31 INFO - PROCESS | 1439 | 10:48:34 INFO - PROCESS | 1439 | Cycle 1(1): loaded http://localhost:44148/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44148/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:48:34 INFO - PROCESS | 1439 | RSS: Main: 176291840 10:48:34 INFO - PROCESS | 1439 | 10:48:37 INFO - PROCESS | 1439 | Cycle 1(1): loaded http://localhost:44148/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44148/tests/kraken/driver.html?testName=imaging-darkroom) 10:48:38 INFO - PROCESS | 1439 | RSS: Main: 175673344 10:48:38 INFO - PROCESS | 1439 | 10:48:41 INFO - PROCESS | 1439 | Cycle 1(1): loaded http://localhost:44148/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44148/tests/kraken/driver.html?testName=imaging-desaturate) 10:48:42 INFO - PROCESS | 1439 | RSS: Main: 177295360 10:48:42 INFO - PROCESS | 1439 | 10:48:45 INFO - PROCESS | 1439 | Cycle 1(1): loaded http://localhost:44148/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44148/tests/kraken/driver.html?testName=json-parse-financial) 10:48:45 INFO - PROCESS | 1439 | RSS: Main: 177225728 10:48:45 INFO - PROCESS | 1439 | 10:48:47 INFO - PROCESS | 1439 | Cycle 1(1): loaded http://localhost:44148/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44148/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:48:48 INFO - PROCESS | 1439 | RSS: Main: 187289600 10:48:48 INFO - PROCESS | 1439 | 10:48:50 INFO - PROCESS | 1439 | Cycle 1(1): loaded http://localhost:44148/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44148/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:48:50 INFO - PROCESS | 1439 | RSS: Main: 185745408 10:48:50 INFO - PROCESS | 1439 | 10:48:52 INFO - PROCESS | 1439 | Cycle 1(1): loaded http://localhost:44148/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44148/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:48:53 INFO - PROCESS | 1439 | RSS: Main: 193818624 10:48:53 INFO - PROCESS | 1439 | 10:48:55 INFO - PROCESS | 1439 | Cycle 1(1): loaded http://localhost:44148/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:48:56 INFO - PROCESS | 1439 | RSS: Main: 198221824 10:48:56 INFO - PROCESS | 1439 | 10:48:58 INFO - PROCESS | 1439 | Cycle 1(1): loaded http://localhost:44148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:48:59 INFO - PROCESS | 1439 | RSS: Main: 198668288 10:48:59 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | Cycle 1(1): loaded http://localhost:44148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44148/tests/kraken/driver.html?testName=ai-astar) 10:49:01 INFO - PROCESS | 1439 | RSS: Main: 258412544 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | __start_tp_report 10:49:01 INFO - PROCESS | 1439 | _x_x_mozilla_page_load 10:49:01 INFO - PROCESS | 1439 | _x_x_mozilla_page_load_details 10:49:01 INFO - PROCESS | 1439 | |i|pagename|runs| 10:49:01 INFO - PROCESS | 1439 | |0;ai-astar;112;110;113;112;112;112;119;110;111;111 10:49:01 INFO - PROCESS | 1439 | |1;audio-beat-detection;152;131;152;173;140;163;157;130;170;130 10:49:01 INFO - PROCESS | 1439 | |2;audio-dft;161;161;160;160;160;160;162;161;161;161 10:49:01 INFO - PROCESS | 1439 | |3;audio-fft;72;73;103;94;73;74;73;114;94;74 10:49:01 INFO - PROCESS | 1439 | |4;audio-oscillator;94;94;142;94;94;94;146;94;94;135 10:49:01 INFO - PROCESS | 1439 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;117;118;118 10:49:01 INFO - PROCESS | 1439 | |6;imaging-darkroom;146;146;147;146;147;152;148;146;147;146 10:49:01 INFO - PROCESS | 1439 | |7;imaging-desaturate;96;96;96;97;95;95;95;95;97;95 10:49:01 INFO - PROCESS | 1439 | |8;json-parse-financial;64;63;64;63;64;65;63;77;62;61 10:49:01 INFO - PROCESS | 1439 | |9;json-stringify-tinderbox;64;65;64;64;64;64;65;65;65;64 10:49:01 INFO - PROCESS | 1439 | |10;stanford-crypto-aes;80;82;82;88;83;81;80;85;82;81 10:49:01 INFO - PROCESS | 1439 | |11;stanford-crypto-ccm;117;117;116;127;123;115;115;115;124;114 10:49:01 INFO - PROCESS | 1439 | |12;stanford-crypto-pbkdf2;142;132;156;138;142;137;141;141;139;143 10:49:01 INFO - PROCESS | 1439 | |13;stanford-crypto-sha256-iterative;69;66;67;66;66;66;65;69;66;67 10:49:01 INFO - PROCESS | 1439 | __end_tp_report 10:49:01 INFO - PROCESS | 1439 | __start_cc_report 10:49:01 INFO - PROCESS | 1439 | _x_x_mozilla_cycle_collect,1129 10:49:01 INFO - PROCESS | 1439 | __end_cc_report 10:49:01 INFO - PROCESS | 1439 | __startTimestamp1458236941524__endTimestamp 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | ------- Summary: start ------- 10:49:01 INFO - PROCESS | 1439 | Number of tests: 14 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | [#0] ai-astar Cycles:10 Average:112.20 Median:112.00 stddev:2.57 (2.3%) stddev-sans-first:2.73 10:49:01 INFO - PROCESS | 1439 | Values: 112.0 110.0 113.0 112.0 112.0 112.0 119.0 110.0 111.0 111.0 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:154.50 stddev:16.38 (10.6%) stddev-sans-first:17.36 10:49:01 INFO - PROCESS | 1439 | Values: 152.0 131.0 152.0 173.0 140.0 163.0 157.0 130.0 170.0 130.0 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 10:49:01 INFO - PROCESS | 1439 | Values: 161.0 161.0 160.0 160.0 160.0 160.0 162.0 161.0 161.0 161.0 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | [#3] audio-fft Cycles:10 Average:84.40 Median:73.50 stddev:15.51 (21.1%) stddev-sans-first:15.79 10:49:01 INFO - PROCESS | 1439 | Values: 72.0 73.0 103.0 94.0 73.0 74.0 73.0 114.0 94.0 74.0 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:94.00 stddev:22.85 (24.3%) stddev-sans-first:23.66 10:49:01 INFO - PROCESS | 1439 | Values: 94.0 94.0 142.0 94.0 94.0 94.0 146.0 94.0 94.0 135.0 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:49:01 INFO - PROCESS | 1439 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.85 (1.3%) stddev-sans-first:1.92 10:49:01 INFO - PROCESS | 1439 | Values: 146.0 146.0 147.0 146.0 147.0 152.0 148.0 146.0 147.0 146.0 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 10:49:01 INFO - PROCESS | 1439 | Values: 96.0 96.0 96.0 97.0 95.0 95.0 95.0 95.0 97.0 95.0 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.00 stddev:4.50 (7.0%) stddev-sans-first:4.77 10:49:01 INFO - PROCESS | 1439 | Values: 64.0 63.0 64.0 63.0 64.0 65.0 63.0 77.0 62.0 61.0 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 10:49:01 INFO - PROCESS | 1439 | Values: 64.0 65.0 64.0 64.0 64.0 64.0 65.0 65.0 65.0 64.0 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:2.46 (3.0%) stddev-sans-first:2.45 10:49:01 INFO - PROCESS | 1439 | Values: 80.0 82.0 82.0 88.0 83.0 81.0 80.0 85.0 82.0 81.0 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:117.00 stddev:4.60 (3.9%) stddev-sans-first:4.85 10:49:01 INFO - PROCESS | 1439 | Values: 117.0 117.0 116.0 127.0 123.0 115.0 115.0 115.0 124.0 114.0 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.10 Median:141.50 stddev:6.15 (4.3%) stddev-sans-first:6.52 10:49:01 INFO - PROCESS | 1439 | Values: 142.0 132.0 156.0 138.0 142.0 137.0 141.0 141.0 139.0 143.0 10:49:01 INFO - PROCESS | 1439 | 10:49:01 INFO - PROCESS | 1439 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:1.34 (2.0%) stddev-sans-first:1.13 10:49:01 INFO - PROCESS | 1439 | Values: 69.0 66.0 67.0 66.0 66.0 66.0 65.0 69.0 66.0 67.0 10:49:01 INFO - PROCESS | 1439 | -------- Summary: end -------- 10:49:01 INFO - PROCESS | 1439 | 10:49:02 INFO - TEST-INFO | 1439: exit 0 10:49:02 INFO - TEST-OK | kraken | took 61712ms 10:49:02 INFO - SUITE-END | took 1178s 10:49:02 INFO - Completed test suite (00:19:38) 10:49:02 INFO - javascript benchmark 10:49:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2629.5003949249644, 2662.786977041837, 2687.34160130768, 2688.166668332817, 2709.7290270972903, 4626.097910907366, 4681.953180468195, 4685.086408150412, 4692.178868697977, 4718.551737584924, 4636.675432719711, 4707.764611769407, 4734.857954261369, 4752.168370535152, 4760.880977975544, 4331.3405986155185, 4334.176506463762, 4355.063661312817, 4389.824407023715, 4471.932921006188, 4262.0, 4385.0, 4391.121775644868, 4439.178751930887, 4470.0, 4324.17840610283, 4336.3929049933195, 4403.735775853459, 4413.271810151321, 4424.469063712343, 4350.108227813291, 4364.738115713068, 4375.0812329410865, 4375.78121093944, 4411.205982923073, 4352.825886964518, 4363.323684828857, 4374.956250437487, 4399.670024748157, 4411.42651455312, 4487.39420178275, 4591.242444996572, 4643.233866412038, 4686.2267725825195, 4695.413073365829, 5084.084864724348, 5090.949090509084, 5097.388313402378, 5120.3855537335385, 5150.0472412603785, 4981.950180498185, 5113.463086375914, 5120.231965205212, 5125.923111153335, 5127.0, 4771.021940502189, 4798.95201047992, 4820.6143508519235, 4865.854024379239, 4866.902661946741, 5158.92261616076, 5160.767765450564, 5167.793288268427, 5169.560587350117, 5221.295125158055, 4895.069936712013, 4963.255511673278, 4970.329005584272, 4970.90058198834, 5026.89946201074, 5089.9745501272255, 5097.592192624581, 5124.256982737482, 5129.307543481582, 5134.922976155361, 5035.1188542005, 5041.344625198701, 5048.0, 5051.015052064886, 5100.464451232641, 4935.555799978019, 5030.0, 5038.798448062036, 5041.571466425322, 5046.949530504648, 4237.173751118502, 4239.173361194599, 4246.363045543193, 4307.483102027777, 4321.092570560155, 3758.473813666089, 3758.5489741231227, 3765.6234376562675, 3804.752691075071, 3807.6573108420375, 4389.122175564899, 4395.450568678915, 4400.22995975703, 4402.427684401007, 4438.955610443919, 4979.925301120486, 5101.20931255656, 5148.176291793295, 5187.714675692798, 5190.195519694454, 4331.805068771912, 4332.761698106571, 4348.021695118637, 4354.085642015212, 4392.38506609075, 4487.080148569536, 4526.23054080807, 4534.79593418297, 4535.659825513099, 4570.680052396367, 4810.302506136591, 4852.0295940811275, 4852.660313778002, 4907.312976183409, 4907.509249075064, 5068.493150684902, 5111.795528178831, 5111.948880511296, 5118.616103792156, 5169.638125331191, 4743.620510359094, 4783.354247176587, 4843.200871856105, 4864.878378040577, 4909.68087074339, 5039.2944987702485, 5043.117454445531, 5068.645194836474, 5108.61685373591, 5110.054639891632, 5100.260462232881, 5131.897362052813, 5135.127028405254, 5143.228515722672, 5189.870253243548, 4801.351817504732, 4885.95114048855, 4945.357103576512, 4968.254761785616, 4977.850664480072, 4851.320815085962, 4854.320395144612, 4863.2461968394955, 4889.926651100308, 4915.188993816123, 4804.73573953422, 4807.4471435783935, 4807.543283388072, 4814.6870453420415, 4856.295837103671, 4830.130576496264, 4918.508149185053, 4939.629527785359, 4991.575716064175, 5006.524380183877, 4872.074305881871, 4890.315355850113, 4897.730624815669, 4924.0, 4948.331975183304], "unit": "score", "name": "dojo.html", "value": 4662.6046348661475}, {"lowerIsBetter": false, "replicates": [548.4405905975907, 552.1248820619321, 558.2630927176127, 569.2798609758655, 582.9533637309015, 26616.733832661666, 33744.0, 34094.48858267128, 34100.31799364014, 34197.82901085491, 37019.0, 37556.81221593888, 37605.05987350311, 37654.05864853373, 37755.24489510208, 7749.535027898316, 7959.840803183933, 7965.402594805384, 7972.3622110231045, 7975.96012019942, 7728.188540203282, 7844.607769611496, 7848.45060845741, 7854.921450785476, 8014.438989270753, 7980.840383192332, 8081.272685458308, 8102.918970810305, 8103.675852965875, 8107.716229931953, 7957.562334071624, 8091.0, 8099.514029158269, 8100.554469504175, 8115.634796434204, 7879.4484386093, 7905.56519391439, 7917.683292668286, 7927.5243485391065, 7943.046834379854, 37871.0, 38380.0, 38387.8080609598, 38394.42408363877, 38403.807980959915, 2943.970560294391, 3017.9396412071856, 3029.166979080748, 3050.740687041604, 3091.335362896988, 28086.157415277576, 28305.15084547467, 28475.715242847513, 28782.280442988882, 28957.71042289571, 3479.9130021749406, 3485.3203625293077, 3485.5643044619424, 3515.753897227195, 3527.3827080260853, 237699.0, 237737.0, 237895.0, 238338.0, 239166.0, 53031.469685302654, 53050.0, 53195.202071968175, 53402.46597534053, 53522.7323863386, 57135.0, 57588.424115759146, 61424.38575614276, 62032.68983655143, 62180.37819621746, 13468.461261549624, 13781.448742050407, 13836.584902452943, 13837.238951857744, 13837.86162138386, 10235.334703244265, 10280.331778434378, 10310.07209351162, 10323.380597164194, 10334.638287659896, 19192.232310707695, 19203.423897283104, 19209.135588898534, 19313.4205973821, 19393.4181974541, 7465.776026719099, 7841.863903847586, 7876.803079923047, 7898.328642065374, 7952.32405245549, 825.1995564302617, 967.2213867836459, 978.6966040527459, 1004.4977511244377, 1035.171862509989, 26082.13096559377, 27287.863560682068, 27463.725362746118, 27496.312592185357, 27646.0, 915.6337465013914, 974.9512524373753, 975.4683697384942, 1001.2690735762934, 1010.2019404670375, 12384.0, 12711.555095571795, 12871.549495767604, 13001.934990325177, 13077.738445231042, 306834.0, 313614.0, 313963.0, 314624.0, 315883.88812782883, 46399.0, 46894.296585551245, 46999.5300047002, 47047.29429058567, 47058.294125588145, 966.4732720667254, 1152.0150271517732, 1231.5689508672071, 1236.8330275412884, 1265.8797414245632, 23653.408664783517, 24449.0, 24642.260732177347, 24837.50324993526, 24956.625650615617, 32360.83819580981, 32766.508502372006, 33034.0, 33411.49882751712, 33462.66537334595, 145742.2712886429, 152889.23555382152, 153422.0, 153673.23163384112, 153931.0, 26425.60361594539, 29495.852520738117, 30496.23759405944, 30570.388592228475, 31158.844205778827, 34270.0, 34401.483977740856, 35067.82266127545, 35316.0, 37901.431478527295, 31568.526472103396, 31800.36399272048, 32402.513962291057, 32426.83786581052, 32871.17822054468, 32184.678153219105, 32383.51424728678, 32873.50689739608, 32904.506432404014, 33048.0, 31631.84184079065, 32242.677573224904, 32410.35179296448, 32749.0, 32813.83593082115, 28002.719972800012, 28908.7109128906, 29538.704612954454, 29697.851510743174, 29923.70076299209, 23487.412814679086, 23838.04647814068, 24162.87918560396, 24199.0, 24215.51568968646], "unit": "score", "name": "ext.html", "value": 16528.39655912628}, {"lowerIsBetter": false, "replicates": [354.1730060309178, 356.20743844945, 364.62443683006506, 366.83492428407226, 368.34802399752436, 15498.302576384061, 15587.751695461608, 17431.389901353454, 17468.301267949268, 17476.12619369033, 16657.66684666309, 16952.83047169531, 17200.741988870177, 17204.913975430107, 17208.39770608029, 4650.000249946261, 5037.0933232018315, 5211.114110601188, 5214.973925130369, 5215.295935048777, 5137.974310128444, 5151.4333423323405, 5165.457626949173, 5180.171172612383, 5192.1952097424955, 4996.075725990685, 5099.974500127512, 5156.252343410203, 5168.121419358718, 5172.715500647463, 5142.07442660321, 5154.123798954187, 5155.58755299577, 5157.226416037587, 5162.277281180638, 4615.284630882219, 4615.769211539409, 4617.12274667812, 4620.1221767864, 4998.45017048128, 11859.881401185963, 11864.584739534075, 11996.520139194421, 12013.399330033464, 12014.819777703342, 1916.4059141666128, 1941.3011315926256, 1991.4722598511405, 1994.8703334283225, 2269.965950510744, 8768.07935166811, 8814.427062240933, 8939.240164586017, 8985.550722463917, 9142.77143071422, 1796.9550761231073, 1798.4424828303138, 1821.225978958937, 1882.745829313039, 1886.528367908023, 59287.0, 60392.0, 60690.0, 61481.38518614846, 62208.02335813124, 10319.638812641522, 10447.947760261302, 10456.274714672147, 10493.0, 10657.84013239802, 13403.731925361439, 13487.05590608648, 13489.460421583026, 13503.932480337535, 13514.391852366667, 7208.675609597476, 7436.925630743732, 7496.062992125984, 7566.054243219598, 7566.886496702554, 7069.6111713856235, 7106.751263705849, 7188.928110718931, 7208.2791720828545, 7237.782866514013, 4422.646188304992, 4436.378906953029, 4452.263617189299, 4472.9776351118035, 4569.748663823521, 1833.4591295567839, 1851.3427733154806, 1856.071964017991, 1875.5311172206948, 1893.7916829148783, 858.219020691168, 868.1492137704959, 871.2333146830748, 873.5675840459013, 912.5847739278612, 15821.68356632861, 16194.109323987059, 16338.428155014755, 16536.090515021788, 16762.0, 869.2437579306044, 870.0, 879.402006635494, 882.2677177942293, 922.7739203895088, 9401.90598094024, 9939.0, 9953.552090155961, 10045.24796683144, 10454.477276136162, 408132.0, 426235.0, 440401.0, 440883.0, 441408.0, 46739.29891051637, 47240.291395629094, 64610.0, 73927.26072739204, 74761.0, 941.3222479814523, 951.0869565217331, 959.6353385713384, 974.5176137811828, 977.726236653738, 12176.512939482676, 15061.698766024838, 15166.165860877758, 15379.538613841603, 15465.149416782186, 34928.47607285842, 35353.29293414169, 35542.64457355393, 35738.8213058933, 35857.64142358543, 43871.80640967875, 45334.77332613316, 46002.0, 46155.0, 46444.7677761609, 7175.497715159889, 7216.855662886608, 7227.27727227273, 7292.927070729224, 7311.378532824557, 9319.767005824908, 10972.670819875417, 11217.0, 11255.0, 11452.541898324307, 9428.245740340619, 10028.247881408777, 10338.0, 10439.947800261254, 10638.574457021632, 4966.503349665005, 6623.774601698701, 6914.8617027660175, 9270.53647317645, 9985.700428987142, 10182.389056656624, 10226.956556301766, 10341.896581034394, 10428.374297542172, 10710.946445267724, 7324.340809327186, 7325.560466372035, 7385.48301618903, 7472.36484898768, 7685.423593230642, 9570.617175313188, 10128.189744820544, 10182.134518566005, 10259.589616415558, 10390.0], "unit": "score", "name": "jquery.html", "value": 7872.749974900304}, {"lowerIsBetter": false, "replicates": [1155.324135380802, 1430.3134495442187, 1440.0567628203528, 1586.8413158684125, 1782.9108544572775, 7113.1819840718335, 7323.670434830432, 7363.595002274879, 7365.33711965923, 7375.04124463819, 7307.780766576998, 7523.51097178683, 7526.548407095578, 7528.698852045912, 7539.359154471863, 1942.2910637617238, 1993.4019794061796, 2239.1267405711706, 2307.538492301542, 2336.158982766203, 2313.791758741713, 2322.3497420722224, 2323.7908588227056, 2325.058351367699, 2326.174208156097, 2232.598132336179, 2249.3139592424304, 2259.8418110732255, 2317.1889838556453, 2317.6986991691056, 2237.7650346713685, 2270.2621647964397, 2275.7610450902584, 2275.943101422461, 2280.6579013148075, 2269.217120093565, 2289.3933107726466, 2291.026313816638, 2295.127851416468, 2296.4603318220206, 7699.384049276045, 7817.413693972918, 7826.921730782677, 7827.25641064098, 7831.765047048598, 4779.784909679072, 4866.3673722416215, 4907.411110666707, 4909.729964851967, 4909.950900491021, 3006.744426723731, 3014.110837303001, 3108.6269647642202, 3135.435621588113, 3159.368126374711, 985.8718366612367, 992.9304948653597, 993.6671215142936, 1015.8120747661707, 1019.6991887393162, 10618.73453163677, 10634.734131646694, 10649.733756656067, 10652.307600005975, 10652.786944261148, 4447.0, 4494.16857881293, 4547.454305483363, 4576.633869290449, 4579.496255411902, 8990.235829954527, 9027.50348730826, 9042.00537940826, 9050.09499050103, 9059.773505662411, 4826.927596086061, 4848.612111031109, 4855.32025516428, 4855.854324370274, 4857.417109946829, 3637.6907962823457, 3752.7560708553856, 4223.915521689549, 4333.848315308949, 4341.08837144197, 3756.6055564165918, 3809.657130858236, 3826.521684789401, 3844.3272427325105, 3872.1287710264965, 1232.796588562895, 1245.9501619935281, 1247.875212478745, 1256.5413624027165, 1257.1765493601706, 945.6595625574788, 993.9662750739295, 1175.5709166154463, 1182.3201659046083, 1188.756304957499, 7054.329838665319, 7100.573965562083, 7160.498765086394, 7191.208967013625, 7195.748148814766, 1036.4506811389974, 1045.414567842011, 1052.8526006359116, 1073.8603981482356, 1094.7372630568607, 5590.2453168821685, 5603.075492543685, 5625.521830644441, 5639.6334238274385, 5656.519195868315, 8773.07882672323, 8794.692185773467, 9065.68270110543, 9169.495677737788, 9169.816603667889, 8816.074312197255, 8892.244159246407, 8962.910370896208, 9040.728778136667, 9063.637454501877, 6981.581105133709, 6996.545224560387, 7211.062561867028, 7227.5302105364035, 7256.2018177999325, 7047.471439641945, 7070.646467676493, 7097.432205423657, 7113.430925525842, 7152.499325047404, 8284.46151000183, 8337.583120843812, 8476.788080298042, 8487.490750554987, 8579.227869491775, 8731.56342182901, 8736.825263494567, 8748.431351962103, 8760.60577274037, 8762.780930476789, 5597.972010139923, 6362.172917520693, 6384.138141350858, 6524.4454221389815, 6619.073329733745, 7053.153621565445, 7077.115360579927, 7104.325089116525, 7137.607431591105, 7146.67839947214, 6291.685415729286, 6432.163818703539, 6439.0, 6482.416582507597, 6533.901991470227, 6319.399657032574, 6341.239051313872, 6402.679866006774, 6455.7740479083, 6499.155109835691, 6838.692258848463, 6874.072000279898, 6886.69009894566, 6899.793006209822, 6902.447804175554, 6349.587276826992, 6375.6174629522375, 6423.132877061536, 6428.357164283534, 6433.646149461637, 6385.393387628168, 6392.0, 6424.550281480251, 6440.516961228021, 6442.742290308335], "unit": "score", "name": "mootools.html", "value": 4418.147446949896}, {"lowerIsBetter": false, "replicates": [324.14264271003196, 326.5037143541816, 326.84801567271217, 329.09827073817746, 332.46473178183106, 5394.649347792396, 5399.217113518543, 5423.349198096224, 5431.402545719968, 5482.1228603423415, 5325.893482130365, 5363.490468405495, 5373.462653734625, 5374.543163831079, 5383.246345511622, 3987.9601203987877, 4083.9387409188885, 4163.937540936889, 4204.054087830229, 4212.136512015038, 4174.582541745832, 4186.225548273564, 4190.72760270583, 4198.055437526547, 4203.453551038361, 4154.584541545836, 4155.62599366057, 4162.1675664867, 4163.250614889319, 4171.207470580595, 3977.741446805963, 4078.714489985717, 4139.544650088488, 4141.482314710661, 4160.875173744793, 3649.6532829381167, 3649.835757390924, 3652.5616925969052, 3662.176010397666, 3670.5595328560744, 5146.871328216787, 5151.381834179922, 5159.896802063938, 5163.793448262065, 5164.948350516484, 4819.855404337841, 4845.757712114416, 4846.61227101831, 4848.321235027099, 4854.053459575384, 5650.830475085754, 5659.547236221134, 5659.6321239119325, 5664.037113690682, 5666.5183459406, 4064.5325787534516, 4065.390191471303, 4066.7763273019973, 4070.409790580349, 4071.1654110907193, 5803.5357171426185, 5916.0534314509905, 5928.258967629046, 5990.341062483167, 6017.217761690996, 4117.155983023473, 4178.435911152016, 4185.979070104691, 4188.350805625133, 4191.434156388848, 4244.0, 4246.936295955563, 4248.63886569645, 4253.957460425418, 4271.893202669959, 4833.975830120898, 4836.322914791932, 4844.346013288232, 4846.345743324606, 4852.126617208936, 5691.4877661010705, 5693.060644993612, 5694.202811606378, 5702.372738998707, 5703.116017017369, 1466.2229018620149, 1485.2054151029147, 1507.4045751928147, 1507.9623009424633, 1508.0, 987.6839411388287, 1025.9384436933808, 1029.7374169586708, 1050.2228351020342, 1053.578568572577, 4928.186849169919, 4944.283078953532, 4977.477364876709, 4977.552020318117, 4978.975105124524, 5840.065589505659, 5846.795362162304, 5894.086416605433, 5894.941050589525, 5896.587238893237, 4931.753412329369, 4965.0566392385335, 4966.230234313687, 4972.204447288416, 4975.477574854661, 3116.9064928052194, 3144.276816332256, 3148.165736079941, 3175.17445464181, 3177.158053115926, 5509.1268968550885, 5518.558515318765, 5536.723163841792, 5538.723063846872, 5542.8337149885565, 5890.764369425261, 6127.601705889103, 6171.753129874754, 6189.319174890758, 6199.938000620026, 5616.803411880564, 5632.746526406321, 5637.267155269788, 5643.774249030075, 5650.830475085754, 5944.6730429826775, 5960.105984102419, 5962.701864906824, 5967.403259673998, 5968.701564921824, 5830.883382332415, 5836.212111365081, 5836.854078648068, 5839.15332276809, 5844.6785426801935, 5422.213779001943, 5624.353199382123, 5625.493705566519, 5632.070708333079, 5634.32388113429, 4012.378081397388, 4061.0, 4088.0393107619093, 4110.301248787653, 4118.032262418389, 5950.054722912186, 5957.791477298274, 5962.344142144448, 5963.254593175853, 5973.283206015306, 5705.62913410627, 5715.971420142872, 5717.485426311652, 5729.627574207663, 5742.913856292075, 5697.54419646419, 5706.144078388275, 5712.971435142797, 5716.085426331767, 5729.455701708331, 5417.106177480671, 5615.522680572197, 5624.212610234652, 5626.324841019104, 5657.773689052557, 5743.9138412923, 5766.019776637898, 5770.990076736638, 5772.134179873053, 5776.480116789509, 5616.157576363578, 5627.127795191752, 5634.943650563606, 5643.746031428514, 5645.661260324394], "unit": "score", "name": "prototype.html", "value": 4301.685655493623}, {"lowerIsBetter": false, "replicates": [651.7914267434421, 661.0150875195957, 715.0632671200724, 725.7205975699358, 747.3759410891902, 12122.393880305983, 12548.937255313711, 12576.937115314433, 12593.118481706273, 12619.55831545896, 12132.939335303334, 12186.939065304683, 12194.390280485984, 12198.207116537418, 12210.816837747441, 643.9742410303583, 784.4704824243641, 796.9123396426388, 811.5779794506852, 818.2676504528444, 809.7692157735047, 809.7854068671807, 816.5957850863831, 816.7958010497375, 817.7015389382863, 845.023997283139, 852.8166444214493, 854.1757204297851, 854.9529775862325, 855.7817756472091, 668.7993601919429, 828.9088200297963, 833.6207025803245, 835.1940377535647, 835.7659855240512, 623.2552100240215, 623.6943897490243, 623.8003838771594, 626.4017862940881, 627.5481653209682, 12348.259104453762, 12397.318147501885, 12402.13185077045, 12427.3786310685, 12453.937730311382, 11646.301221926711, 12234.853736309356, 12390.194637348544, 12660.68348291291, 12778.666772683484, 9821.214302855755, 9867.851982220272, 9976.351537150062, 10051.246156538216, 10062.899371006342, 3356.0770788033487, 3364.108511244522, 3381.070205693429, 3506.5266189064405, 3513.1744040150543, 43444.348334775, 43541.56458435438, 43684.56315436837, 43837.34243986343, 43942.56057439448, 10001.599936002478, 10059.597616095421, 10163.085322320878, 10217.948910255402, 10230.64192753265, 16929.0, 17093.145342733063, 17120.14399280031, 17127.00277451441, 17128.40050598223, 6691.096701945273, 6746.696398661974, 6839.247682754893, 6863.313668633096, 6883.174019117738, 3727.813609319523, 3764.1154328732728, 3772.2078363543965, 3803.790791506494, 3879.0302424393903, 2760.323720688444, 2760.3513174403997, 2768.197222805404, 2778.097118436516, 2790.6651201855907, 506.30636028641, 511.411876342202, 515.2014377714528, 519.057909893542, 524.0802391802363, 562.2044806598699, 566.2497191221648, 584.4622946888873, 585.771549095853, 586.7359688140353, 7592.620368981639, 7763.340116090083, 7804.531728096219, 8093.55485448306, 8159.224873636995, 482.3753239554715, 552.5082676417991, 564.610418811019, 569.8091139468324, 573.86801035762, 3531.646835316499, 3588.8743893963588, 3616.764910280823, 3658.6158453362546, 3726.0312318796764, 49251.75374123178, 49740.502594974314, 49822.75088624534, 49886.50113498891, 50014.49985500171, 43526.34710479345, 45510.54489455063, 45650.77174614172, 46226.30660540095, 46607.53392466032, 39893.800530997156, 41111.0, 41192.58807411948, 41260.999999999396, 41300.793496032325, 8317.500949943023, 8364.6235919385, 8401.663933442594, 8473.0, 8565.100664430145, 29611.555826663047, 29614.0, 29616.703832961393, 29741.85129074341, 30991.535126972663, 36801.0, 38929.80535097307, 39381.80309098436, 39536.802315988236, 39610.80194599008, 9559.522023898639, 9595.616175352907, 9685.467299298325, 9687.854682179914, 9768.120869121529, 10635.89364106349, 11184.273022253528, 11194.104471642411, 11233.494492747683, 11566.0, 10446.791064178522, 10617.522211500347, 10645.467726613793, 10655.520501577292, 10955.945220273848, 10452.790944181226, 10553.366797992145, 10647.94676026615, 10675.839862402225, 10968.23222374458, 10486.423246721504, 10554.2084343673, 10655.467226638482, 10676.0, 10739.838902416313, 8872.068432814462, 8951.597178127131, 9083.18251357381, 9205.447673139633, 9350.906490935276, 8810.647574096964, 8866.246369058445, 8877.422967507091, 9008.32437567172, 9324.300677449082], "unit": "score", "name": "yui.html", "value": 5829.600448418547}], "name": "dromaeo_css", "value": 6376.619762849577}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 113.0, 112.0, 112.0, 112.0, 119.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [152.0, 131.0, 152.0, 173.0, 140.0, 163.0, 157.0, 130.0, 170.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 162.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 103.0, 94.0, 73.0, 74.0, 73.0, 114.0, 94.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.4}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 142.0, 94.0, 94.0, 94.0, 146.0, 94.0, 94.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 152.0, 148.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 95.0, 95.0, 95.0, 95.0, 97.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 64.0, 63.0, 64.0, 65.0, 63.0, 77.0, 62.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 64.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 82.0, 88.0, 83.0, 81.0, 80.0, 85.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 127.0, 123.0, 115.0, 115.0, 115.0, 124.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [142.0, 132.0, 156.0, 138.0, 142.0, 137.0, 141.0, 141.0, 139.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.1}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 67.0, 66.0, 66.0, 66.0, 65.0, 69.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1512.9}]} 10:49:02 INFO - Return code: 0 10:49:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:49:02 ERROR - # TBPL SUCCESS # 10:49:02 INFO - Running post-action listener: _resource_record_post_action 10:49:02 INFO - Running post-run listener: _resource_record_post_run 10:49:03 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 517988352; Read time: 0; Write time: 476148 10:49:03 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 232800256; Read time: 0; Write time: 257908 10:49:03 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 285188096; Read time: 0; Write time: 218240 10:49:03 INFO - Running post-run listener: _upload_blobber_files 10:49:03 INFO - Blob upload gear active. 10:49:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:49:03 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 10:49:03 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'] 10:49:03 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 10:49:04 INFO - (blobuploader) - INFO - Open directory for files ... 10:49:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:49:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:49:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:04 INFO - (blobuploader) - INFO - Done attempting. 10:49:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:49:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:49:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:49:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:49:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:49:05 INFO - (blobuploader) - INFO - Done attempting. 10:49:05 INFO - (blobuploader) - INFO - Iteration through files over. 10:49:05 INFO - Return code: 0 10:49:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:49:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:49:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50a2d5f2bb38a7f0d9cb51e06b51e551939898cb6654f8036bf720a6a304e476c05a1a68c2ef70bd251b04ffb7fb880803a3207e58b4d2e12cd3c56cd2036334", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b919fa2b197d36455d882f5cc50639bc7441f5428d6a761807ce0805b1e779253a982debb59863e6408bae5cd7fc4b72efca67b2ea3c47c0870f45b7657e7ce"} 10:49:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:49:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:49:05 INFO - Contents: 10:49:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/50a2d5f2bb38a7f0d9cb51e06b51e551939898cb6654f8036bf720a6a304e476c05a1a68c2ef70bd251b04ffb7fb880803a3207e58b4d2e12cd3c56cd2036334", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b919fa2b197d36455d882f5cc50639bc7441f5428d6a761807ce0805b1e779253a982debb59863e6408bae5cd7fc4b72efca67b2ea3c47c0870f45b7657e7ce"} 10:49:05 INFO - Running post-run listener: copy_logs_to_upload_dir 10:49:05 INFO - Copying logs to upload dir... 10:49:05 INFO - mkdir: /builds/slave/test/build/upload/logs 10:49:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.487821 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-03-17 10:49:05.389407) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 10:49:05.393463) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088 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/50a2d5f2bb38a7f0d9cb51e06b51e551939898cb6654f8036bf720a6a304e476c05a1a68c2ef70bd251b04ffb7fb880803a3207e58b4d2e12cd3c56cd2036334", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b919fa2b197d36455d882f5cc50639bc7441f5428d6a761807ce0805b1e779253a982debb59863e6408bae5cd7fc4b72efca67b2ea3c47c0870f45b7657e7ce"} build_url:https://queue.taskcluster.net/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/Ee-lzNgUTny7BDLUXdskSA/artifacts/public/build/firefox-48.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/50a2d5f2bb38a7f0d9cb51e06b51e551939898cb6654f8036bf720a6a304e476c05a1a68c2ef70bd251b04ffb7fb880803a3207e58b4d2e12cd3c56cd2036334", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4b919fa2b197d36455d882f5cc50639bc7441f5428d6a761807ce0805b1e779253a982debb59863e6408bae5cd7fc4b72efca67b2ea3c47c0870f45b7657e7ce"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 10:49:05.418202) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 10:49:05.418532) ========= 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=14ef55db36f7623abb31b9cf000001d5-1458235703.752036-604094088 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 10:49:05.501982) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 10:49:05.502334) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 10:49:05.502663) ========= ========= Total master_lag: 0.29 =========