builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1457576964.34 results: success (0) buildid: 20160309180025 builduid: fed9c73b03654b84b8268c9c7175e670 revision: 41a9ead06eee530634b596df6e6738fb38505bf0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:24.341176) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:24.341572) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:24.341910) ========= 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=5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006348 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:24.364850) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:24.365221) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:24.378460) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:24.378807) ========= 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=5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004669 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:24.432839) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:24.433113) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:24.433467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:24.433736) ========= 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=5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-09 18:29:24-- 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% 41.6M=0s 2016-03-09 18:29:24 (41.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149787 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:24.597147) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:24.597715) ========= 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=5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023159 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:24.650165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:24.650835) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 41a9ead06eee530634b596df6e6738fb38505bf0 --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 41a9ead06eee530634b596df6e6738fb38505bf0 --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=5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-09 18:29:24,767 truncating revision to first 12 chars 2016-03-09 18:29:24,767 Setting DEBUG logging. 2016-03-09 18:29:24,767 attempt 1/10 2016-03-09 18:29:24,767 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/41a9ead06eee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 18:29:25,031 unpacking tar archive at: fx-team-41a9ead06eee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545927 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:25.211471) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:25.211894) ========= echo 41a9ead06eee530634b596df6e6738fb38505bf0 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'41a9ead06eee530634b596df6e6738fb38505bf0'] 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=5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 41a9ead06eee530634b596df6e6738fb38505bf0 program finished with exit code 0 elapsedTime=0.004715 script_repo_revision: '41a9ead06eee530634b596df6e6738fb38505bf0' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:25.265457) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:25.266086) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 18:29:25.277308) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-09 18:29:25.277620) ========= /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=5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:29:25 INFO - MultiFileLogger online at 20160309 18:29:25 in /builds/slave/test 18:29:25 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 18:29:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:29:25 INFO - {'append_to_log': False, 18:29:25 INFO - 'base_work_dir': '/builds/slave/test', 18:29:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:29:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:29:25 INFO - 'branch': 'Fx-Team-Non-PGO', 18:29:25 INFO - 'buildbot_json_path': 'buildprops.json', 18:29:25 INFO - 'config_files': ('talos/linux_config.py',), 18:29:25 INFO - 'default_actions': ('clobber', 18:29:25 INFO - 'read-buildbot-config', 18:29:25 INFO - 'download-and-extract', 18:29:25 INFO - 'populate-webroot', 18:29:25 INFO - 'create-virtualenv', 18:29:25 INFO - 'install', 18:29:25 INFO - 'run-tests'), 18:29:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:29:25 INFO - 'download_minidump_stackwalk': True, 18:29:25 INFO - 'download_symbols': 'ondemand', 18:29:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:29:25 INFO - 'tooltool.py': '/tools/tooltool.py', 18:29:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:29:25 INFO - '/tools/misc-python/virtualenv.py')}, 18:29:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:29:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:29:25 INFO - 'installer_path': 'installer.exe', 18:29:25 INFO - 'log_level': 'info', 18:29:25 INFO - 'log_name': 'talos', 18:29:25 INFO - 'log_to_console': True, 18:29:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:29:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:29:25 INFO - 'opt_config_files': (), 18:29:25 INFO - 'pip_index': False, 18:29:25 INFO - 'sps_profile': False, 18:29:25 INFO - 'sps_profile_interval': 0, 18:29:25 INFO - 'suite': 'dromaeojs', 18:29:25 INFO - 'system_bits': '32', 18:29:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:29:25 INFO - 'title': 'talos-linux64-ix-039', 18:29:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:29:25 INFO - 'use_talos_json': True, 18:29:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:29:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:29:25 INFO - 'work_dir': 'build'} 18:29:25 INFO - ##### 18:29:25 INFO - ##### Running clobber step. 18:29:25 INFO - ##### 18:29:25 INFO - Running pre-action listener: _resource_record_pre_action 18:29:25 INFO - Running main action method: clobber 18:29:25 INFO - rmtree: /builds/slave/test/build 18:29:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:29:25 INFO - Running post-action listener: _resource_record_post_action 18:29:25 INFO - ##### 18:29:25 INFO - ##### Running read-buildbot-config step. 18:29:25 INFO - ##### 18:29:25 INFO - Running pre-action listener: _resource_record_pre_action 18:29:25 INFO - Running main action method: read_buildbot_config 18:29:25 INFO - Using buildbot properties: 18:29:25 INFO - { 18:29:25 INFO - "project": "", 18:29:25 INFO - "product": "firefox", 18:29:25 INFO - "script_repo_revision": "production", 18:29:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:29:25 INFO - "repository": "", 18:29:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:29:25 INFO - "buildid": "20160309180025", 18:29:25 INFO - "pgo_build": "False", 18:29:25 INFO - "basedir": "/builds/slave/test", 18:29:25 INFO - "buildnumber": 1427, 18:29:25 INFO - "slavename": "talos-linux64-ix-039", 18:29:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:29:25 INFO - "platform": "ubuntu64_hw", 18:29:25 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:29:25 INFO - "branch": "fx-team", 18:29:25 INFO - "repo_path": "integration/fx-team", 18:29:25 INFO - "revision": "41a9ead06eee530634b596df6e6738fb38505bf0", 18:29:25 INFO - "stage_platform": "linux64", 18:29:25 INFO - "builduid": "fed9c73b03654b84b8268c9c7175e670", 18:29:25 INFO - "slavebuilddir": "test" 18:29:25 INFO - } 18:29:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:29:25 INFO - Running post-action listener: _resource_record_post_action 18:29:25 INFO - ##### 18:29:25 INFO - ##### Running download-and-extract step. 18:29:25 INFO - ##### 18:29:25 INFO - Running pre-action listener: _resource_record_pre_action 18:29:25 INFO - Running main action method: download_and_extract 18:29:25 INFO - mkdir: /builds/slave/test/build/tests 18:29:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:25 INFO - https://queue.taskcluster.net/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:29:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:29:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:29:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/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 18:29:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/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 18:29:26 INFO - Downloaded 1361 bytes. 18:29:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:29:26 INFO - Using the following test package requirements: 18:29:26 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:29:26 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:29:26 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:29:26 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:26 INFO - u'jsshell-linux-x86_64.zip'], 18:29:26 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:29:26 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:29:26 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:29:26 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:29:26 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:29:26 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:29:26 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:29:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:26 INFO - https://queue.taskcluster.net/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:29:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:29:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:29:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/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 18:29:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/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 18:29:27 INFO - Downloaded 22091896 bytes. 18:29:27 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'] 18:29:27 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 18:29:28 INFO - Return code: 0 18:29:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:28 INFO - https://queue.taskcluster.net/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:29:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:29:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:29:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/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 18:29:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/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 18:29:30 INFO - Downloaded 22091896 bytes. 18:29:30 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'] 18:29:30 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 18:29:32 INFO - Return code: 0 18:29:32 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')]} 18:29:32 INFO - https://queue.taskcluster.net/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:29:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:29:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:29:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/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 18:29:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/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 18:29:32 INFO - Downloaded 10845161 bytes. 18:29:32 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'] 18:29:32 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 18:29:33 INFO - Return code: 0 18:29:33 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')]} 18:29:33 INFO - https://queue.taskcluster.net/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:29:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:29:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:29:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/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 18:29:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/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 18:29:34 INFO - Downloaded 54418394 bytes. 18:29:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:29:34 INFO - mkdir: /builds/slave/test/properties 18:29:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:29:34 INFO - Writing to file /builds/slave/test/properties/build_url 18:29:34 INFO - Contents: 18:29:34 INFO - build_url:https://queue.taskcluster.net/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:29:35 INFO - Running post-action listener: _resource_record_post_action 18:29:35 INFO - Running post-action listener: set_extra_try_arguments 18:29:35 INFO - ##### 18:29:35 INFO - ##### Running populate-webroot step. 18:29:35 INFO - ##### 18:29:35 INFO - Running pre-action listener: _resource_record_pre_action 18:29:35 INFO - Running main action method: populate_webroot 18:29:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:29:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:29:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:29:35 INFO - '--tppagecycles', 18:29:35 INFO - '7'], 18:29:35 INFO - 'tests': ['tsvgm']}}, 18:29:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:29:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:29:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:29:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:29:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:29:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:29:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:29:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:35 INFO - 'talos_options': ['--e10s'], 18:29:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:29:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:35 INFO - 'tests': ['damp', 'tps']}, 18:29:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:35 INFO - 'talos_options': ['--e10s'], 18:29:35 INFO - 'tests': ['damp', 'tps']}, 18:29:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:29:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:29:35 INFO - 'other': {'tests': ['a11yr', 18:29:35 INFO - 'ts_paint', 18:29:35 INFO - 'tpaint', 18:29:35 INFO - 'sessionrestore', 18:29:35 INFO - 'sessionrestore_no_auto_restore', 18:29:35 INFO - 'tabpaint']}, 18:29:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:29:35 INFO - 'tests': ['a11yr', 18:29:35 INFO - 'ts_paint', 18:29:35 INFO - 'tpaint', 18:29:35 INFO - 'sessionrestore', 18:29:35 INFO - 'sessionrestore_no_auto_restore', 18:29:35 INFO - 'tabpaint']}, 18:29:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:29:35 INFO - 'tests': ['a11yr', 18:29:35 INFO - 'ts_paint', 18:29:35 INFO - 'tpaint', 18:29:35 INFO - 'sessionrestore', 18:29:35 INFO - 'sessionrestore_no_auto_restore', 18:29:35 INFO - 'tabpaint']}, 18:29:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:29:35 INFO - 'tests': ['a11yr', 18:29:35 INFO - 'ts_paint', 18:29:35 INFO - 'tpaint', 18:29:35 INFO - 'sessionrestore', 18:29:35 INFO - 'sessionrestore_no_auto_restore', 18:29:35 INFO - 'tabpaint']}, 18:29:35 INFO - 'other_l64': {'tests': ['a11yr', 18:29:35 INFO - 'ts_paint', 18:29:35 INFO - 'tpaint', 18:29:35 INFO - 'sessionrestore', 18:29:35 INFO - 'sessionrestore_no_auto_restore', 18:29:35 INFO - 'tabpaint']}, 18:29:35 INFO - 'other_nol64': {'tests': ['a11yr', 18:29:35 INFO - 'ts_paint', 18:29:35 INFO - 'tpaint', 18:29:35 INFO - 'sessionrestore', 18:29:35 INFO - 'sessionrestore_no_auto_restore', 18:29:35 INFO - 'tabpaint']}, 18:29:35 INFO - 'svgr': {'tests': ['tsvgx', 18:29:35 INFO - 'tsvgr_opacity', 18:29:35 INFO - 'tart', 18:29:35 INFO - 'tscrollx', 18:29:35 INFO - 'cart']}, 18:29:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:29:35 INFO - 'tests': ['tsvgx', 18:29:35 INFO - 'tsvgr_opacity', 18:29:35 INFO - 'tart', 18:29:35 INFO - 'tscrollx', 18:29:35 INFO - 'cart']}, 18:29:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:35 INFO - 'tests': ['tp5o']}, 18:29:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:35 INFO - 'talos_options': ['--e10s'], 18:29:35 INFO - 'tests': ['tp5o']}, 18:29:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:35 INFO - 'talos_options': ['--xperf_path', 18:29:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:29:35 INFO - 'tests': ['tp5n']}, 18:29:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:29:35 INFO - 'talos_options': ['--e10s', 18:29:35 INFO - '--xperf_path', 18:29:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:29:35 INFO - 'tests': ['tp5n']}}, 18:29:35 INFO - 'talos.zip': {'path': '', 18:29:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:29:35 INFO - Running post-action listener: _resource_record_post_action 18:29:35 INFO - ##### 18:29:35 INFO - ##### Running create-virtualenv step. 18:29:35 INFO - ##### 18:29:35 INFO - Running pre-action listener: _resource_record_pre_action 18:29:35 INFO - Running main action method: create_virtualenv 18:29:35 INFO - Creating virtualenv /builds/slave/test/build/venv 18:29:35 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 18:29:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:29:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:29:35 INFO - Using real prefix '/usr' 18:29:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:29:35 INFO - Installing distribute.............................................................................................................................................................................................done. 18:29:37 INFO - Installing pip.................done. 18:29:37 INFO - Return code: 0 18:29:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:29: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')]} 18:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29: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')]} 18:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:37 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 0x7fd97b8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013160>, '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 0x1014060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10144f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', '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 18:29:37 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 18:29:37 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 18:29:37 INFO - Using env: {'DISPLAY': ':0', 18:29:37 INFO - 'HOME': '/home/cltbld', 18:29:37 INFO - 'LANG': 'en_US.UTF-8', 18:29:37 INFO - 'LANGUAGE': 'en_US:en', 18:29:37 INFO - 'LOGNAME': 'cltbld', 18:29:37 INFO - 'MAIL': '/var/mail/cltbld', 18:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:37 INFO - 'MOZ_NO_REMOTE': '1', 18:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:37 INFO - 'NO_EM_RESTART': '1', 18:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:37 INFO - 'PWD': '/builds/slave/test', 18:29:37 INFO - 'SHELL': '/bin/bash', 18:29:37 INFO - 'SHLVL': '1', 18:29:37 INFO - 'TERM': 'linux', 18:29:37 INFO - 'TMOUT': '86400', 18:29:37 INFO - 'USER': 'cltbld', 18:29:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', 18:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:37 INFO - '_': '/tools/buildbot/bin/python'} 18:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:38 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 18:29:38 INFO - Cleaning up... 18:29:38 INFO - Return code: 0 18:29:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:38 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 0x7fd97b8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013160>, '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 0x1014060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10144f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', '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 18:29:38 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 18:29:38 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 18:29:38 INFO - Using env: {'DISPLAY': ':0', 18:29:38 INFO - 'HOME': '/home/cltbld', 18:29:38 INFO - 'LANG': 'en_US.UTF-8', 18:29:38 INFO - 'LANGUAGE': 'en_US:en', 18:29:38 INFO - 'LOGNAME': 'cltbld', 18:29:38 INFO - 'MAIL': '/var/mail/cltbld', 18:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:38 INFO - 'MOZ_NO_REMOTE': '1', 18:29:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:38 INFO - 'NO_EM_RESTART': '1', 18:29:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:38 INFO - 'PWD': '/builds/slave/test', 18:29:38 INFO - 'SHELL': '/bin/bash', 18:29:38 INFO - 'SHLVL': '1', 18:29:38 INFO - 'TERM': 'linux', 18:29:38 INFO - 'TMOUT': '86400', 18:29:38 INFO - 'USER': 'cltbld', 18:29:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', 18:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:38 INFO - '_': '/tools/buildbot/bin/python'} 18:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:38 INFO - Downloading/unpacking psutil>=0.7.1 18:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:29:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:29:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:29:40 INFO - Installing collected packages: psutil 18:29:40 INFO - Running setup.py install for psutil 18:29:40 INFO - building 'psutil._psutil_linux' extension 18:29:40 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 18:29:40 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 18:29:40 INFO - building 'psutil._psutil_posix' extension 18:29:40 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 18:29:40 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 18:29:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:29:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:29:40 INFO - Successfully installed psutil 18:29:40 INFO - Cleaning up... 18:29:40 INFO - Return code: 0 18:29:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:29: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')]} 18:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29: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')]} 18:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:40 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 0x7fd97b8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013160>, '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 0x1014060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10144f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', '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 18:29:40 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 18:29:40 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 18:29:40 INFO - Using env: {'DISPLAY': ':0', 18:29:40 INFO - 'HOME': '/home/cltbld', 18:29:40 INFO - 'LANG': 'en_US.UTF-8', 18:29:40 INFO - 'LANGUAGE': 'en_US:en', 18:29:40 INFO - 'LOGNAME': 'cltbld', 18:29:40 INFO - 'MAIL': '/var/mail/cltbld', 18:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:40 INFO - 'MOZ_NO_REMOTE': '1', 18:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:40 INFO - 'NO_EM_RESTART': '1', 18:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:40 INFO - 'PWD': '/builds/slave/test', 18:29:40 INFO - 'SHELL': '/bin/bash', 18:29:40 INFO - 'SHLVL': '1', 18:29:40 INFO - 'TERM': 'linux', 18:29:40 INFO - 'TMOUT': '86400', 18:29:40 INFO - 'USER': 'cltbld', 18:29:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', 18:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:40 INFO - '_': '/tools/buildbot/bin/python'} 18:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:29:42 INFO - Installing collected packages: mozsystemmonitor 18:29:42 INFO - Running setup.py install for mozsystemmonitor 18:29:42 INFO - Successfully installed mozsystemmonitor 18:29:42 INFO - Cleaning up... 18:29:42 INFO - Return code: 0 18:29:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd97b8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013160>, '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 0x1014060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10144f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', '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 18:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:29:42 INFO - Using env: {'DISPLAY': ':0', 18:29:42 INFO - 'HOME': '/home/cltbld', 18:29:42 INFO - 'LANG': 'en_US.UTF-8', 18:29:42 INFO - 'LANGUAGE': 'en_US:en', 18:29:42 INFO - 'LOGNAME': 'cltbld', 18:29:42 INFO - 'MAIL': '/var/mail/cltbld', 18:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:42 INFO - 'MOZ_NO_REMOTE': '1', 18:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:42 INFO - 'NO_EM_RESTART': '1', 18:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:42 INFO - 'PWD': '/builds/slave/test', 18:29:42 INFO - 'SHELL': '/bin/bash', 18:29:42 INFO - 'SHLVL': '1', 18:29:42 INFO - 'TERM': 'linux', 18:29:42 INFO - 'TMOUT': '86400', 18:29:42 INFO - 'USER': 'cltbld', 18:29:42 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', 18:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:42 INFO - '_': '/tools/buildbot/bin/python'} 18:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:43 INFO - Downloading/unpacking blobuploader==1.2.4 18:29:43 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 18:29:43 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 18:29:43 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 18:29:43 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 18:29:43 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 18:29:43 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 18:29:44 INFO - Downloading blobuploader-1.2.4.tar.gz 18:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:29:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:29:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29:45 INFO - Downloading docopt-0.6.1.tar.gz 18:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:29:45 INFO - Installing collected packages: blobuploader, requests, docopt 18:29:45 INFO - Running setup.py install for blobuploader 18:29:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:29:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:29:45 INFO - Running setup.py install for requests 18:29:46 INFO - Running setup.py install for docopt 18:29:46 INFO - Successfully installed blobuploader requests docopt 18:29:46 INFO - Cleaning up... 18:29:46 INFO - Return code: 0 18:29:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:46 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 0x7fd97b8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013160>, '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 0x1014060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10144f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', '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 18:29:46 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 18:29:46 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 18:29:46 INFO - Using env: {'DISPLAY': ':0', 18:29:46 INFO - 'HOME': '/home/cltbld', 18:29:46 INFO - 'LANG': 'en_US.UTF-8', 18:29:46 INFO - 'LANGUAGE': 'en_US:en', 18:29:46 INFO - 'LOGNAME': 'cltbld', 18:29:46 INFO - 'MAIL': '/var/mail/cltbld', 18:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:46 INFO - 'MOZ_NO_REMOTE': '1', 18:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:46 INFO - 'NO_EM_RESTART': '1', 18:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:46 INFO - 'PWD': '/builds/slave/test', 18:29:46 INFO - 'SHELL': '/bin/bash', 18:29:46 INFO - 'SHLVL': '1', 18:29:46 INFO - 'TERM': 'linux', 18:29:46 INFO - 'TMOUT': '86400', 18:29:46 INFO - 'USER': 'cltbld', 18:29:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', 18:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:46 INFO - '_': '/tools/buildbot/bin/python'} 18:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:29:46 INFO - Running setup.py (path:/tmp/pip-kEU69z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:29:46 INFO - Running setup.py (path:/tmp/pip-GuGKWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:29:46 INFO - Running setup.py (path:/tmp/pip-5kZ1KR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:29:46 INFO - Running setup.py (path:/tmp/pip-AGWOaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:29:46 INFO - Running setup.py (path:/tmp/pip-LYwjg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:29:46 INFO - Running setup.py (path:/tmp/pip-DUF0IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:29:46 INFO - Running setup.py (path:/tmp/pip-plQwG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:29:47 INFO - Running setup.py (path:/tmp/pip-P7MJlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:29:47 INFO - Running setup.py (path:/tmp/pip-Drrsa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:29:47 INFO - Running setup.py (path:/tmp/pip-t6UhaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:29:47 INFO - Running setup.py (path:/tmp/pip-UdXTAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:29:47 INFO - Running setup.py (path:/tmp/pip-ziDAiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:29:47 INFO - Running setup.py (path:/tmp/pip-TzXP7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:29:47 INFO - Running setup.py (path:/tmp/pip-Zb1InJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:47 INFO - Running setup.py (path:/tmp/pip-CdvArA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:29:47 INFO - Running setup.py (path:/tmp/pip-hnNKXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:29:47 INFO - Running setup.py (path:/tmp/pip-Jy5stQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:29:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:29:47 INFO - Running setup.py install for manifestparser 18:29:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:29:47 INFO - Running setup.py install for mozcrash 18:29:47 INFO - Running setup.py install for mozdebug 18:29:48 INFO - Running setup.py install for mozdevice 18:29:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:29:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:29:48 INFO - Running setup.py install for mozfile 18:29:48 INFO - Running setup.py install for mozhttpd 18:29:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:29:48 INFO - Running setup.py install for mozinfo 18:29:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:29:48 INFO - Running setup.py install for mozInstall 18:29:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:29:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:29:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:29:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:29:48 INFO - Running setup.py install for mozleak 18:29:48 INFO - Running setup.py install for mozlog 18:29:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:29:48 INFO - Running setup.py install for moznetwork 18:29:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:29:48 INFO - Running setup.py install for mozprocess 18:29:48 INFO - Running setup.py install for mozprofile 18:29:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:29:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:29:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:29:49 INFO - Running setup.py install for mozrunner 18:29:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:29:49 INFO - Running setup.py install for mozscreenshot 18:29:49 INFO - Running setup.py install for moztest 18:29:49 INFO - Running setup.py install for mozversion 18:29:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:29:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:29:49 INFO - Cleaning up... 18:29:49 INFO - Return code: 0 18:29:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:49 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 0x7fd97b8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013160>, '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 0x1014060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10144f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', '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 18:29:49 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 18:29:49 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 18:29:49 INFO - Using env: {'DISPLAY': ':0', 18:29:49 INFO - 'HOME': '/home/cltbld', 18:29:49 INFO - 'LANG': 'en_US.UTF-8', 18:29:49 INFO - 'LANGUAGE': 'en_US:en', 18:29:49 INFO - 'LOGNAME': 'cltbld', 18:29:49 INFO - 'MAIL': '/var/mail/cltbld', 18:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:49 INFO - 'MOZ_NO_REMOTE': '1', 18:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:49 INFO - 'NO_EM_RESTART': '1', 18:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:49 INFO - 'PWD': '/builds/slave/test', 18:29:49 INFO - 'SHELL': '/bin/bash', 18:29:49 INFO - 'SHLVL': '1', 18:29:49 INFO - 'TERM': 'linux', 18:29:49 INFO - 'TMOUT': '86400', 18:29:49 INFO - 'USER': 'cltbld', 18:29:49 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', 18:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:49 INFO - '_': '/tools/buildbot/bin/python'} 18:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:29:49 INFO - Running setup.py (path:/tmp/pip-p0Hnon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:29:49 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)) 18:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:29:49 INFO - Running setup.py (path:/tmp/pip-fHvlQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:29:49 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)) 18:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:29:49 INFO - Running setup.py (path:/tmp/pip-YDA2k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:29:49 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)) 18:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:29:49 INFO - Running setup.py (path:/tmp/pip-z3ckmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:29:50 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)) 18:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:29:50 INFO - Running setup.py (path:/tmp/pip-Ni4asL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:29:50 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)) 18:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:29:50 INFO - Running setup.py (path:/tmp/pip-j69l0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:29:50 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)) 18:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:29:50 INFO - Running setup.py (path:/tmp/pip-x5BqY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:29:50 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)) 18:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:29:50 INFO - Running setup.py (path:/tmp/pip-8VpIXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:29:50 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)) 18:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:29:50 INFO - Running setup.py (path:/tmp/pip-RJ8nJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:29:50 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)) 18:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:29:50 INFO - Running setup.py (path:/tmp/pip-6KdBoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:29:50 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)) 18:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:29:50 INFO - Running setup.py (path:/tmp/pip-VUR7zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:29:50 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)) 18:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:29:50 INFO - Running setup.py (path:/tmp/pip-1keblq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:29:50 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)) 18:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:29:50 INFO - Running setup.py (path:/tmp/pip-Tvsnrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:29:50 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)) 18:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:29:50 INFO - Running setup.py (path:/tmp/pip-CvZbuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:29:50 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)) 18:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:50 INFO - Running setup.py (path:/tmp/pip-2ktXVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:29:50 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)) 18:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:29:50 INFO - Running setup.py (path:/tmp/pip-DFb_as-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:29:50 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)) 18:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:29:50 INFO - Running setup.py (path:/tmp/pip-a_k6ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:29:50 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)) 18:29:50 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)) 18:29:50 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)) 18:29:50 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)) 18:29:50 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)) 18:29:50 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)) 18:29:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29:52 INFO - Downloading blessings-1.6.tar.gz 18:29:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:29:53 INFO - Installing collected packages: blessings 18:29:53 INFO - Running setup.py install for blessings 18:29:53 INFO - Successfully installed blessings 18:29:53 INFO - Cleaning up... 18:29:53 INFO - Return code: 0 18:29:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:29:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:29:53 INFO - Reading from file tmpfile_stdout 18:29:53 INFO - Current package versions: 18:29:53 INFO - argparse == 1.2.1 18:29:53 INFO - blessings == 1.6 18:29:53 INFO - blobuploader == 1.2.4 18:29:53 INFO - docopt == 0.6.1 18:29:53 INFO - manifestparser == 1.1 18:29:53 INFO - mozInstall == 1.12 18:29:53 INFO - mozcrash == 0.17 18:29:53 INFO - mozdebug == 0.1 18:29:53 INFO - mozdevice == 0.48 18:29:53 INFO - mozfile == 1.2 18:29:53 INFO - mozhttpd == 0.7 18:29:53 INFO - mozinfo == 0.9 18:29:53 INFO - mozleak == 0.1 18:29:53 INFO - mozlog == 3.1 18:29:53 INFO - moznetwork == 0.27 18:29:53 INFO - mozprocess == 0.22 18:29:53 INFO - mozprofile == 0.28 18:29:53 INFO - mozrunner == 6.11 18:29:53 INFO - mozscreenshot == 0.1 18:29:53 INFO - mozsystemmonitor == 0.0 18:29:53 INFO - moztest == 0.7 18:29:53 INFO - mozversion == 1.4 18:29:53 INFO - psutil == 3.1.1 18:29:53 INFO - requests == 1.2.3 18:29:53 INFO - wsgiref == 0.1.2 18:29:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:29:53 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')]} 18:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:53 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')]} 18:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:53 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 0x7fd97b8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013160>, '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 0x1014060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10144f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', '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 18:29:53 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 18:29:53 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 18:29:53 INFO - Using env: {'DISPLAY': ':0', 18:29:53 INFO - 'HOME': '/home/cltbld', 18:29:53 INFO - 'LANG': 'en_US.UTF-8', 18:29:53 INFO - 'LANGUAGE': 'en_US:en', 18:29:53 INFO - 'LOGNAME': 'cltbld', 18:29:53 INFO - 'MAIL': '/var/mail/cltbld', 18:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:53 INFO - 'MOZ_NO_REMOTE': '1', 18:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:53 INFO - 'NO_EM_RESTART': '1', 18:29:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:53 INFO - 'PWD': '/builds/slave/test', 18:29:53 INFO - 'SHELL': '/bin/bash', 18:29:53 INFO - 'SHLVL': '1', 18:29:53 INFO - 'TERM': 'linux', 18:29:53 INFO - 'TMOUT': '86400', 18:29:53 INFO - 'USER': 'cltbld', 18:29:53 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', 18:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:53 INFO - '_': '/tools/buildbot/bin/python'} 18:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:53 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)) 18:29:53 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)) 18:29:53 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)) 18:29:53 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)) 18:29:53 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)) 18:29:53 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)) 18:29:53 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)) 18:29:53 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)) 18:29:53 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)) 18:29:53 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)) 18:29:53 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)) 18:29:53 INFO - Cleaning up... 18:29:53 INFO - Return code: 0 18:29:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:29:53 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')]} 18:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:53 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')]} 18:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:53 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 0x7fd97b8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013160>, '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 0x1014060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10144f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', '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 18:29:53 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 18:29:53 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 18:29:53 INFO - Using env: {'DISPLAY': ':0', 18:29:53 INFO - 'HOME': '/home/cltbld', 18:29:53 INFO - 'LANG': 'en_US.UTF-8', 18:29:53 INFO - 'LANGUAGE': 'en_US:en', 18:29:53 INFO - 'LOGNAME': 'cltbld', 18:29:53 INFO - 'MAIL': '/var/mail/cltbld', 18:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:53 INFO - 'MOZ_NO_REMOTE': '1', 18:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:53 INFO - 'NO_EM_RESTART': '1', 18:29:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:53 INFO - 'PWD': '/builds/slave/test', 18:29:53 INFO - 'SHELL': '/bin/bash', 18:29:53 INFO - 'SHLVL': '1', 18:29:53 INFO - 'TERM': 'linux', 18:29:53 INFO - 'TMOUT': '86400', 18:29:53 INFO - 'USER': 'cltbld', 18:29:53 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', 18:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:53 INFO - '_': '/tools/buildbot/bin/python'} 18:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:53 INFO - Downloading/unpacking jsonschema 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:29:55 INFO - Downloading/unpacking functools32 (from jsonschema) 18:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:55 INFO - Downloading functools32-3.2.3-2.tar.gz 18:29:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:29:55 INFO - warning: no files found matching '*.txt' 18:29:55 INFO - no previously-included directories found matching 'build' 18:29:55 INFO - no previously-included directories found matching 'dist' 18:29:55 INFO - no previously-included directories found matching '.git*' 18:29:55 INFO - Installing collected packages: jsonschema, functools32 18:29:56 INFO - Running setup.py install for functools32 18:29:56 INFO - warning: no files found matching '*.txt' 18:29:56 INFO - no previously-included directories found matching 'build' 18:29:56 INFO - no previously-included directories found matching 'dist' 18:29:56 INFO - no previously-included directories found matching '.git*' 18:29:56 INFO - Successfully installed jsonschema functools32 18:29:56 INFO - Cleaning up... 18:29:56 INFO - Return code: 0 18:29:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:29:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd97b8f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf84410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1013160>, '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 0x1014060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10144f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', '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 18:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:29:56 INFO - Using env: {'DISPLAY': ':0', 18:29:56 INFO - 'HOME': '/home/cltbld', 18:29:56 INFO - 'LANG': 'en_US.UTF-8', 18:29:56 INFO - 'LANGUAGE': 'en_US:en', 18:29:56 INFO - 'LOGNAME': 'cltbld', 18:29:56 INFO - 'MAIL': '/var/mail/cltbld', 18:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:29:56 INFO - 'MOZ_NO_REMOTE': '1', 18:29:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:29:56 INFO - 'NO_EM_RESTART': '1', 18:29:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:29:56 INFO - 'PWD': '/builds/slave/test', 18:29:56 INFO - 'SHELL': '/bin/bash', 18:29:56 INFO - 'SHLVL': '1', 18:29:56 INFO - 'TERM': 'linux', 18:29:56 INFO - 'TMOUT': '86400', 18:29:56 INFO - 'USER': 'cltbld', 18:29:56 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', 18:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:29:56 INFO - '_': '/tools/buildbot/bin/python'} 18:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:29:56 INFO - Downloading/unpacking flake8 18:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:29:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:29:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:29:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:29:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29: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 18:29:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:29:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:29:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:29:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:29:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:29:58 INFO - no previously-included directories found matching 'docs/_build' 18:29:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:29:58 INFO - Running setup.py install for pep8 18:29:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:29:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:29:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:29:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:29:58 INFO - no previously-included directories found matching 'docs/_build' 18:29:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:29:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:29:59 INFO - Cleaning up... 18:29:59 INFO - Return code: 0 18:29:59 INFO - Running post-action listener: _resource_record_post_action 18:29:59 INFO - Running post-action listener: _start_resource_monitoring 18:29:59 INFO - Starting resource monitoring. 18:29:59 INFO - ##### 18:29:59 INFO - ##### Running install step. 18:29:59 INFO - ##### 18:29:59 INFO - Running pre-action listener: _resource_record_pre_action 18:29:59 INFO - Running main action method: install 18:29:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:29:59 INFO - Reading from file tmpfile_stdout 18:29:59 INFO - Detecting whether we're running mozinstall >=1.0... 18:29:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:29:59 INFO - Reading from file tmpfile_stdout 18:29:59 INFO - Output received: 18:29:59 INFO - Usage: mozinstall [options] installer 18:29:59 INFO - Options: 18:29:59 INFO - -h, --help show this help message and exit 18:29:59 INFO - -d DEST, --destination=DEST 18:29:59 INFO - Directory to install application into. [default: 18:29:59 INFO - "/builds/slave/test"] 18:29:59 INFO - --app=APP Application being installed. [default: firefox] 18:29:59 INFO - mkdir: /builds/slave/test/build/application 18:29:59 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'] 18:29:59 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 18:30:16 INFO - Reading from file tmpfile_stdout 18:30:16 INFO - Output received: 18:30:16 INFO - /builds/slave/test/build/application/firefox/firefox 18:30:16 INFO - Running post-action listener: _resource_record_post_action 18:30:16 INFO - ##### 18:30:16 INFO - ##### Running run-tests step. 18:30:16 INFO - ##### 18:30:16 INFO - Running pre-action listener: _resource_record_pre_action 18:30:16 INFO - Running main action method: run_tests 18:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:30:16 INFO - Python 2.7.3 18:30:16 INFO - Return code: 0 18:30:16 INFO - grabbing minidump binary from tooltool 18:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:30:16 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 0x1013160>, '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 0x1014060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10144f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:30:16 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 18:30:16 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 18:30:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:30:16 INFO - Return code: 0 18:30:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:30:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:30:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:30:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:30:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:30:17 INFO - Return code: 0 18:30:17 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/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 18:30:17 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/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 18:30:17 INFO - Using env: {'DISPLAY': ':0', 18:30:17 INFO - 'HOME': '/home/cltbld', 18:30:17 INFO - 'LANG': 'en_US.UTF-8', 18:30:17 INFO - 'LANGUAGE': 'en_US:en', 18:30:17 INFO - 'LOGNAME': 'cltbld', 18:30:17 INFO - 'MAIL': '/var/mail/cltbld', 18:30:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:30:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:30:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:30:17 INFO - 'MOZ_NO_REMOTE': '1', 18:30:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:30:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:30:17 INFO - 'NO_EM_RESTART': '1', 18:30:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:30:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:30:17 INFO - 'PWD': '/builds/slave/test', 18:30:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:30:17 INFO - 'SHELL': '/bin/bash', 18:30:17 INFO - 'SHLVL': '1', 18:30:17 INFO - 'TERM': 'linux', 18:30:17 INFO - 'TMOUT': '86400', 18:30:17 INFO - 'USER': 'cltbld', 18:30:17 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382', 18:30:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:30:17 INFO - '_': '/tools/buildbot/bin/python'} 18:30:17 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/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 18:30:17 INFO - mozversion application_buildid: 20160309180025 18:30:17 INFO - mozversion application_changeset: 41a9ead06eee530634b596df6e6738fb38505bf0 18:30:17 INFO - mozversion application_display_name: Nightly 18:30:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:30:17 INFO - mozversion application_name: Firefox 18:30:17 INFO - mozversion application_remotingname: firefox 18:30:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:30:17 INFO - mozversion application_vendor: Mozilla 18:30:17 INFO - mozversion application_version: 48.0a1 18:30:17 INFO - mozversion platform_buildid: 20160309180025 18:30:17 INFO - mozversion platform_changeset: 41a9ead06eee530634b596df6e6738fb38505bf0 18:30:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:30:17 INFO - mozversion platform_version: 48.0a1 18:30:17 INFO - using testdate: 1457577017 18:30:17 INFO - actual date: 1457577017 18:30:17 INFO - starting webserver on 'localhost:46528' 18:30:17 INFO - SUITE-START | Running 2 tests 18:30:17 INFO - TEST-START | dromaeo_css 18:30:17 INFO - operating with platform_type : linux_ 18:30:17 INFO - Initialising browser for dromaeo_css test... 18:30:17 INFO - TEST-INFO | started process 5751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxuboSy/profile http://localhost:46528/getInfo.html) 18:30:22 INFO - PROCESS | 5751 | __metrics Screen width/height:1600/1200 18:30:22 INFO - PROCESS | 5751 | colorDepth:24 18:30:22 INFO - PROCESS | 5751 | Browser inner width/height: 1024/697 18:30:22 INFO - PROCESS | 5751 | __metrics 18:30:23 ERROR - PROCESS | 5751 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:30:24 INFO - TEST-INFO | 5751: exit 0 18:30:24 INFO - Browser initialized. 18:30:24 INFO - Running cycle 1/1 for dromaeo_css test... 18:30:24 INFO - TEST-INFO | started process 5844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxuboSy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:30:36 INFO - PROCESS | 5844 | RSS: Main: 153477120 18:30:36 INFO - PROCESS | 5844 | 18:31:27 INFO - PROCESS | 5844 | 1457577087836 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] 18:33:39 INFO - PROCESS | 5844 | Cycle 1(1): loaded http://localhost:46528/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46528/tests/dromaeo/cssquery-ext.html) 18:33:40 INFO - PROCESS | 5844 | RSS: Main: 247394304 18:33:40 INFO - PROCESS | 5844 | 18:36:42 INFO - PROCESS | 5844 | Cycle 1(1): loaded http://localhost:46528/tests/dromaeo/cssquery-ext.html (next: http://localhost:46528/tests/dromaeo/cssquery-jquery.html) 18:36:43 INFO - PROCESS | 5844 | RSS: Main: 233013248 18:36:43 INFO - PROCESS | 5844 | 18:39:45 INFO - PROCESS | 5844 | Cycle 1(1): loaded http://localhost:46528/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46528/tests/dromaeo/cssquery-mootools.html) 18:39:45 INFO - PROCESS | 5844 | RSS: Main: 224374784 18:39:45 INFO - PROCESS | 5844 | 18:42:47 INFO - PROCESS | 5844 | Cycle 1(1): loaded http://localhost:46528/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46528/tests/dromaeo/cssquery-prototype.html) 18:42:48 INFO - PROCESS | 5844 | RSS: Main: 202563584 18:42:48 INFO - PROCESS | 5844 | 18:45:50 INFO - PROCESS | 5844 | Cycle 1(1): loaded http://localhost:46528/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46528/tests/dromaeo/cssquery-yui.html) 18:45:51 INFO - PROCESS | 5844 | RSS: Main: 198537216 18:45:51 INFO - PROCESS | 5844 | 18:48:54 INFO - PROCESS | 5844 | Cycle 1(1): loaded http://localhost:46528/tests/dromaeo/cssquery-yui.html (next: http://localhost:46528/tests/dromaeo/cssquery-dojo.html) 18:48:54 INFO - PROCESS | 5844 | RSS: Main: 270450688 18:48:54 INFO - PROCESS | 5844 | 18:48:54 INFO - PROCESS | 5844 | __start_tp_report 18:48:54 INFO - PROCESS | 5844 | _x_x_mozilla_page_load 18:48:54 INFO - PROCESS | 5844 | _x_x_mozilla_page_load_details 18:48:54 INFO - PROCESS | 5844 | |i|pagename|runs| 18:48:54 INFO - PROCESS | 5844 | |0;dojo.html;2588.7670109690125;2684.154491335228;2685.597160425937;2693.070890542762;2712.742289482499;4497.370368148462;4601.677882548214;4609.562091601301;4636.744979026153;4652.255639097741;4414.801333939972;4558.1567410029165;4629.259318509039;4645.233536466488;4646.767661616923;4144.91710165798;4218.831246750126;4241.830326786932;4310.590493903074;4362.890927726817;4107.301758701028;4293.162833247518;4329.567043295661;4344.4786625604975;4347.521772605027;4225.8520951766695;4249.426327445817;4258.169656916903;4293.613574778254;4320.891977700551;4205.87382378526;4217.325227963542;4228.725132866384;4237.279662457389;4259;4110.897227569305;4190.120074784299;4215.936760948588;4222.873313800591;4258.339957306623;4469.620082292977;4522.592966632986;4538.72767633943;4541.772911354452;4583.060472603109;4921.384826896638;4921.680090794087;4927.581155601778;4928.7535623219055;4928.926066108976;4746.43042834862;4856.223004319328;4937.876553086202;4980.228064649985;4997.875053123665;4539.024109816405;4551.658625603093;4565.223911934979;4568.223402021665;4594.977025114887;4980.9252861207115;4985.202367621163;4986.825461108844;4987.925181122286;5027.371578552681;4612.07758448305;4730.314104454835;4788.1381351356395;4852.539008794159;4854.368932038812;4919.532644398776;4919.827806026772;4937.2982090192945;4941.110600092018;4972.378452693413;4864.294677271776;4891.5353041461;4893;4894.559489645949;4937.679050861682;4690.7654617269;4771.379720636364;4831.541003604652;4860.902781944412;4874.2444921037295;4022.818973146157;4031.91936161281;4034.4150098236178;4052.452918855917;4061.411095391152;3540.291941611688;3585.372559802024;3589.335972845032;3591.712662986955;3618.692411145082;4195.370694395865;4215.557366476476;4246.299360605527;4288;4289.1636130954785;4889.779959901742;4892.363992680928;4914.729689867092;4920.6555541111775;4964.925526117111;4084.36692312692;4223.978880105641;4230.175115852379;4234.491860976641;4270.12462445198;4314.50383205929;4349.869503914888;4356.607905288539;4385.824567017284;4390.978045109818;4651.162790697707;4677.953220467888;4679.742614156254;4696.9060618787435;4714.5992590630185;4706.505816889315;4867.172580661225;4913.533214344631;4919.262110683426;4920.040592084652;4650.465196502446;4656.976715116402;4656.976715116402;4668.276417155346;4700.106979673851;4823.348847905488;4824.155772739827;4839.903201936012;4848;4875.512448755097;4788.186008378653;4870.4155501340065;4889.951100488949;4894;4947.925781113358;4740.549647783455;4746.240601503743;4777.355057067391;4799;4809.134355815847;4745.406824146981;4765.309030190672;4767.904641907212;4777.402824646919;4815.036992601564;4473.977630111959;4643.187442197669;4674.462436819809;4716.646251531218;4732.02993386348;4772.761361931959;4785.736784476748;4804.591609713214;4805.783739731651;4845.95154048455;4688.953110468988;4700;4700.083483720641;4718.5753282203395;4743.786529606107 18:48:54 INFO - PROCESS | 5844 | |1;ext.html;485.7935377464579;491.6558409113619;505.7648193589981;512.0450360078454;519.6359556165066;24949.376265593346;34349.48475772862;34989.125271868215;35012.64987350126;35058.47412288811;37500.81249593748;38017;38043.23913521735;38121.23757524848;38166;7687.461877668579;7889.802754931144;7893.486923349992;7900.091489478697;7903.249191326815;7620.504667196615;7748.031496062992;7750.224977502261;7771.417143714216;7957.084935232436;7947.205279472064;8037.678492860307;8040.517568945853;8043.477173983672;8051.9597402012905;7869.252421020023;7910.52536847791;7921.920780792176;7951.920480795205;7959.164287749761;7712.961435192844;7811.296983271476;7814.452988290822;7818.530888146673;7969.242921922408;37919.81040094782;37987.430188547194;38021.42967855484;38192;38556;2949.3658863344485;3048.4512787698204;3094.520349345855;3217.6138863336314;3273.29624130813;28532.714672853213;29076;29379.118626441243;29389.265268368246;29559.26101847471;3418.4017796885696;3497.266675265146;3511.157322242669;3572.5355703758346;3649.8905032849057;215140;217154;217774;217955;218682;38103.618963810564;54190;54493.727531362885;54511.72744136254;54574.454255457735;36554.80671159686;37067.25865482675;37104.80532725421;37128.44307335392;37132.44301335482;10855.588773459558;11115.055220306365;11142.220044596801;11146.554137834559;11161.441927903572;8763.737087887373;8855.291576673852;8868.600912958933;8881.555922203865;8889.511076890833;13044.54344097952;13122.803157952638;13341.332933353293;13416.530421435204;13487.190768553919;5259.263703081571;5390.649607775482;5414.675119492843;5438.945610543844;5454.290942177491;740.714824792448;743.6319022083995;768.277818850279;860.2773670117132;878.7407714724171;25512.872435638074;26741.732582674314;27283.181504554894;27410.86294568554;27478.725212747617;863.2489733931394;907.8592818113203;920.7053742802239;925.6528801699362;955.603424578806;13627.182369057888;13689.794653080211;13828.585142445743;14069.226192559303;14180.432782688784;260701;261637;264044;264791;265388;46720.299195512096;47494.76252618784;47504;47641;47641.761791191515;1098.6045023791428;1130.5138790320077;1139.5043156227068;1146.7133216695827;1156.5373850459714;23393.76606233984;24500.274711552443;24731.876340618182;26515.60226596564;26684;36797;36893.26213475662;37135;37148.44277335896;37181.62818371782;176611;177215;178062;178148;178465;23783.881080594485;28938.565921511614;29191.708082919748;29204.415911681222;29499.705002949697;33614.49578256377;33715.325693486484;33932.151696206805;34468.48297275493;34585.1353716149;28802;29332.70667293385;29511;29567;30137.69862301349;31059.37881242408;31699.683003170594;31710.524342134424;31727.206819829687;31950;31847.203819904687;32264.67735322617;32319.030429087165;32549.511757324133;32552.186195345304;27500.58749118725;29381.11856644304;31858.36283274275;36267.45598816073;36380.27239455143;24013.639795402734;24593;24608.75391246136;25088.247352579452;25523.106691265715 18:48:54 INFO - PROCESS | 5844 | |2;jquery.html;324.18952618453864;338.4787427361863;341.8275315667261;341.84616922384936;350.0269251480884;14718.558443246706;15005.324760385782;15565.066096034232;16527.256273467694;16586.25361858716;13404.731905361887;13782.310884455786;14036;14268.785968210484;14548.345324460399;4941.357623508948;5074.213496907967;5082.263071854579;5095.312132862072;5114.2584325273;4917.164082106051;4956.975215123919;4959.132151873426;5068.4424713281505;5080.161773307418;4944.950550494503;4995.175795993657;5001.6998980061135;5006.799728010875;5034.496550344955;4851.248056551205;5001.099802035632;5003.174476211439;5010.273510340999;5040.193569028937;4821.156297647897;4838.298446725205;4844.128056949748;4854.611631069506;4857.295692124658;11192.944035279854;11355.261907975955;11566.42167891602;11645.883541164565;11699.2980421175;1641.3434626149517;1649.2990479046357;1668.7413450915005;1695.2456157010135;1700.5408539694338;8324.417290789646;8782.780430489225;9058.23005044572;9112.954435227848;9200.861987070199;1565.9451919182775;1763.1713094845402;1768.2838450427598;1772.7961284452194;1781.1806568978286;41840.790796045825;49673;54499.72750136224;56685.43314566843;59167.70416147935;8197.549134797524;9217.585208665627;9262;9388.624455021723;9473.90526094744;10481.423521706227;10542.314749541256;10552.841707374395;10554.683359499073;11432.828507572392;5414.431484694129;5508.724563771795;5731.541476681856;6763.797086087426;6829.931700683029;6325.272593651789;6338.207724034496;6416.101745755598;6446.677666116675;6461.741530338828;4225.57744225575;4240.851570195028;4248.065425606362;4256.212600668886;4324.070324880166;1595.6409807793154;1603.2384617306918;1628.7149748793913;1634;1650.6616143690514;777.6150805351388;783.6316931042401;817.1011886924335;834.3867257565685;942.6936245720168;15293.464728734441;15633.218339083;15792.60518487047;15918;16027.759583606256;797.968081276754;813.259933460548;834.9499030058216;843.7595285343771;852.4586887326468;8888.822223555493;8905.643774249087;8976.551172441352;9051.456912585267;9186.08139186076;292974;296760;298093;381969;385183;59239.40760592339;60782.39217607856;62741;70739.64630176817;72398.63800680963;850.6980022092192;878.7495563764296;880.2473884828507;880.528917029399;882.0429833630454;14344.282785860456;14344.49794257196;14648.414063437343;14761.778573321624;14939.850601493847;30934;31370.372592548476;31557;32464.83767581147;32615.673843261262;44140;44461.77769111134;44636.33045504255;44700.77649611731;45154.54845451503;7042.859142817218;7121.537100088478;7166.570005799668;7271.636418179176;7323.084614423197;10230.386176829117;10848.40333781618;11052.778944421227;11156.274842135235;11315.886841131483;9572.160981800957;9668.854967175357;9843.60625574969;9888.802223955337;10368.274220804773;7218.314260145278;9290.210332121846;9389.48357840298;9636.325457217927;9647.469389183661;7233.674484648098;7369.77890663281;7475.514091584029;7548.056492938383;7730.92269077302;9864.85202721974;10121.392716437038;10261.538230779484;10433.634822781167;10515.894841051491;7048.577085374894;7261.636918153966;7375.37309328713;10864.511097000495;11175.329480231212 18:48:54 INFO - PROCESS | 5844 | |3;mootools.html;1229.0659099084694;1322.1538215542053;1322.352047496727;1425.2374979386032;1709.9999999999993;7091.290870912906;7216.711331546739;7258.274172582739;7268.563886166827;7276.16324122726;7076.469264805148;7271.309225623558;7275.818104547389;7277.454190935675;7282.745103921364;1803.4769916724135;2170.5116348821466;2188.7701791311883;2212.126210146991;2233.7766223377694;2198.1976578548874;2210.270610698474;2212.9114835406563;2214.3135627955303;2214.966775498369;2101.8528702990798;2212.23677831148;2214.9778502215013;2216.5899308627954;2217.0688310909377;2154.095279982403;2155.073318473056;2175.815055720258;2195.5279614882716;2211.579799838026;2192.2655910270078;2205.404540773998;2205.6470964645578;2209.5359974405396;2210.237468073512;7482.326590606872;7547.773566793005;7554.811129721746;7566.205548417392;7567.545947243183;4564.6348292136545;4664.090502352043;4690.554397332248;4697.131030759287;4697.553732395417;2852.9001484947926;2967.317516971109;3019.849007549614;3026.772992025607;3031.924201894948;913.7441516375426;928.2713070239829;930.2418528898926;940.9529523523796;956.3735753081743;10255.384676919408;10393.324433911772;10418.218633602435;10435.895641043568;10449.738756531071;4166.8749937501925;4279.16556271524;4338.717983331137;4371.78141092944;4371.846985355497;8997.820043599091;9018.09819018093;9041.141091596288;9052.909470905339;9059.139381758723;3790.7156963227867;4577.313402989578;4591.862244132614;4602.654800889946;4608.861734147981;3920.196359746245;3966.7619942803526;3981.5421226558738;4009.4386785850006;4016.9756712038243;3571.4464258040043;3631.3645112105805;3659.3047321009453;3668.798216098087;3697.334479793663;1166.1370585766642;1171.3557543351124;1173.0732721150196;1173.9706507337385;1176.7822952753768;1173.436750359832;1179.8466199394024;1186.543180875352;1188.857337119534;1200.5317926008688;7012.7545535906;7066.929330706627;7101.644917754092;7104.538205016657;7145.857082858418;425.4787884841045;426.83566826771914;436.8383698031749;438.2680922858833;453.61896007353323;5124.8206312778875;5133.845984620468;5134.666246693953;5155.200943853709;5184.326037615161;8954.417962832395;9076.954615227014;9260.953695231616;9274.30442716799;9364.62541498346;9096.181343678969;9115.407498512575;9115.544222788834;9131.360804743605;9211.263098952068;7065.752698655522;7069.939509073577;7136.857262854714;7156.713731450788;7173.426125910019;6663.466922646274;6668.466522678077;6705.865882682221;6716.932830671631;6718.630475323904;8038.236367545074;8079.83840323202;8343.874841877256;8480.109588493366;8491.448055876595;8398.034226064081;8582.884225050953;8590.527520986405;8612.095729948265;8748.518831464076;5485.122380419114;6099.11562823397;6313.337099604475;6668.166479190101;6729.461643068445;6834.897476537756;6850.314968503109;6864.347886950732;6888.896666549906;6901.1718593769065;6200.410960958701;6393.200849893763;6479.449246814073;6483.384078512534;6524.771632992823;6199.380061993765;6225.564210505221;6283.560150789401;6291.465225455888;6382.138411314413;6722.932770672426;6750.0887380205;6785.796426107225;6796.728130874907;6798.796036118924;6096.451319381277;6107.053406721965;6248.187735594343;6256.249250090018;6315.4947604192475;6194.473469755121;6196.194494715838;6205.9760139576465;6245.9063114052415;6247.5939063960695 18:48:54 INFO - PROCESS | 5844 | |4;prototype.html;307.4818930102777;312.55617023826164;315.427499089153;315.58342987256816;316.05972232607985;5165.974170129149;5218.425973142956;5264.868378290545;5301.973490132549;5304.681719096857;5158.329417175762;5233.502817232356;5257.1851363038695;5278.3665960084745;5288.021715982536;3886.7667939923554;3910.882673519799;4067;4085.775282359469;4095.8156882940266;4051.0885050863467;4054.97972510137;4055.3308704063943;4056.71602987791;4068.8575899843513;4006.819693113817;4007.3588225883864;4011.819468123927;4019.336809426441;4021.5978402159844;3816.999999999986;3899.961000389988;4008.4767788240574;4013.9197216055513;4014.2172276406113;3458.6887180153653;3459.705924996378;3470.323286959044;3470.4794280857823;3474.4267195912644;5033.748312584356;5053;5057;5065.493450654942;5073.492650734897;4539.0694907543875;4546.408966834323;4547.567981041796;4548.613367863735;4548.7725613719185;5476.890462190774;5477.096279113942;5486;5492.945070549284;5493.670379777226;3755.4366844973474;3758.4362345648096;3759.962400376016;3764.5670747864074;3770.830312635938;5608.298962629671;5650.745716442729;5739.655620662774;5792.594518383715;5794.159846822229;3883.6310550497656;3905.6680182184264;3908.6286802753693;3914.9021274468364;3918.0988372674447;3956.624120708528;3962.2471730371135;3965.900852478711;3968;3975.6024397560013;4556.84051058218;4558.566936141061;4567.566081222279;4568.1548913451115;4573.977130114328;5501.394846566875;5506.421825708243;5506.91739623906;5509.834704958857;5510.256115424447;1361.6527785414655;1381.5717127690448;1382.979255311171;1385.9307034648227;1386.2375693368606;867.1805144138855;896.6547879066476;927.7448701606977;945.2863088368238;945.6312038305067;4763.404574428197;4824.890275236715;4852.636052296092;4857.271409288635;4860.635452341088;5748.9425105748405;5764.596478246483;5773.797917072966;5774.105013722879;5781.682007489544;4874.000829829876;4874.36633237684;4875.390576177978;4875.439324477659;4885.5358740919555;3029.606151200374;3085.2595377109333;3088.1507585414192;3090.0420869530067;3091.8608662610236;5399.6490228135835;5410.729463526808;5412.782124022064;5416.810411635653;5417.59368047398;5738.282714660668;5896.233489646319;5925.525957923442;5927.851803704942;5933.3473317934995;5447.700376479253;5463.863403414946;5465.699386533699;5471.863203419946;5473.17902314656;5749.252597162509;5750.194972703741;5757.539396848326;5763.049096898964;5776.913346299725;5572.164175373727;5634.943650563442;5635.690037048002;5636.126400407943;5640.661560306395;5459.69971651563;5464.398916119303;5466.671999680032;5469.617126801086;5471.945280547144;3751.4185301278344;3898.8830335089992;3908.081600823747;3927.7446965947124;3933.685305175522;5681.715914204356;5694.800681976111;5729.656220626775;5761.39505351932;5762.078067509178;5462.126059830408;5492.286002819608;5492.862678433071;5494.587905907153;5497.560195184456;5473.781048758005;5489.231507588861;5495.258140151188;5497.972510137423;5499.642523235977;5383.327084114486;5387;5389.218563308376;5389.83830485086;5393.137098064448;5385.353757549119;5493.478119578634;5548.195511650869;5548.667079975215;5554.861128471821;5371.328583927009;5394.271773310553;5394.352677678704;5400.432954539717;5408.675479471244 18:48:54 INFO - PROCESS | 5844 | |5;yui.html;603.4568888000796;720.3264947274299;740.6815069520107;743.4275607782006;755.2145768400864;11930.463129159187;11945.283283003026;12036.338001409918;12103.697407564816;12103.878961210396;11582.710432239199;11680.941595292034;11688.47401866916;11710.355930423844;11713;613.5521069619181;764.7285213749122;783.5690370296343;809.0938149272794;810.6392655268407;792.2750683124963;795.8090058386003;799.0092285565886;799.4084377560592;799.4963173200875;848.9023762267357;852.799592095857;853.4793775796759;853.995730021349;854.0221446443818;640.2253273539023;828.0808302783905;843.6541018182515;844.3625063077368;845.0366582096415;619.6653806944245;624.1449214576014;624.3600309682566;625.327772644409;625.4683519008852;11694.2983420995;11721.062315014779;11760.470778814888;11814;11822.88177118235;10287.279890407675;10873.510692018877;11470.311781293065;11496.252743571642;11533.653990380219;9476.526173691287;9529.904700952971;9627.518624068769;9705.805883882353;9730.951345243298;2974.107767669712;2996.0562422836956;3021.9546706799415;3055.8319292438905;3091.8608662610236;41333.379999300036;41852.58147418517;42362.576374236174;42390.15219695589;42613.57386426158;9437.292203084658;9530.380525265835;9552.42685438876;9600.32797704154;9646.565904534313;16946.491605251616;17129.657406852042;17130.143492825307;17133.82866171322;17148.485545433658;6154.9384506154365;6314.526410519229;6363.204599425072;6400.775972840928;6580.539362244693;3420.3330350581396;3432.22774875656;3520.4543295789194;3551.396262635358;3582.946255806165;2523.873806309677;2624.6325514427995;2632.0524611139977;2692.8788204530842;2727.5090483712725;445.66797735687123;523.7014901506182;532.2256117349248;536.0351367538493;537.9408265090836;522.2844702757171;553.3000754046135;566.3289002532013;580.5413723158741;593.2169536212244;7676.309132178131;7721.806954826175;7937.285644292041;7965.8805117923275;8053.154418785943;475.40099474662173;488.85334399679954;596.2695697770197;598.7874304621884;599.9850003749854;3311.205310725457;3423.6747508987105;3728.832202550892;3779.3197224499854;3869.2648396804516;49486.50513494891;49816.75091624519;50393;50521.49478505168;50526.49473505291;43116.56883431188;44613.33080003803;44654.55345446569;44771.328430073576;45040;39216;39392.80303598521;40477.79761101176;40505.797471012454;40768.18463630711;7730.884036739341;8033;8323.667053318042;8357.247847693738;8381.203785640355;28304.575431368135;28368.574471382533;28801.135965921058;30514.694853051184;31454.842725786224;34781.65218347784;34874.82562587171;38123.61876381201;38213.61786382212;38761.6123838758;9818.558164882741;9933.255005874444;9940.304178707422;10000.449975251431;10000.649977250761;11419.31484110956;11454.198206125824;11498.13763967689;11603.6518904433;11816.468258928197;8523.531205783742;9396.248300136109;10666.200034997251;10893.400862952614;11036.947915470457;10502.159827213653;10525.894741052798;10737.04821082507;10784.568617255221;11017.1186305097;10477.68566942993;10647.30792498485;10693.518791654238;10694;10896.945515272373;8260.504369737835;8434.536100514286;8509.404341696269;8520.786980325542;8886.200241978253;7322.267773222635;7781.727639532589;7901.960490197513;7949.562774047483;8101.797455063671 18:48:54 INFO - PROCESS | 5844 | __end_tp_report 18:48:54 INFO - PROCESS | 5844 | __start_cc_report 18:48:54 INFO - PROCESS | 5844 | _x_x_mozilla_cycle_collect,876 18:48:54 INFO - PROCESS | 5844 | __end_cc_report 18:48:54 INFO - PROCESS | 5844 | __startTimestamp1457578134276__endTimestamp 18:48:54 INFO - PROCESS | 5844 | 18:48:54 INFO - PROCESS | 5844 | ------- Summary: start ------- 18:48:54 INFO - PROCESS | 5844 | Number of tests: 6 18:48:54 INFO - PROCESS | 5844 | 18:48:54 INFO - PROCESS | 5844 | [#0] dojo.html Cycles:165 Average:4527.86 Median:4668.28 stddev:461.83 (9.9%) stddev-sans-first:437.48 18:48:54 INFO - PROCESS | 5844 | Values: 2588.8 2684.2 2685.6 2693.1 2712.7 4497.4 4601.7 4609.6 4636.7 4652.3 4414.8 4558.2 4629.3 4645.2 4646.8 4144.9 4218.8 4241.8 4310.6 4362.9 4107.3 4293.2 4329.6 4344.5 4347.5 4225.9 4249.4 4258.2 4293.6 4320.9 4205.9 4217.3 4228.7 4237.3 4259.0 4110.9 4190.1 4215.9 4222.9 4258.3 4469.6 4522.6 4538.7 4541.8 4583.1 4921.4 4921.7 4927.6 4928.8 4928.9 4746.4 4856.2 4937.9 4980.2 4997.9 4539.0 4551.7 4565.2 4568.2 4595.0 4980.9 4985.2 4986.8 4987.9 5027.4 4612.1 4730.3 4788.1 4852.5 4854.4 4919.5 4919.8 4937.3 4941.1 4972.4 4864.3 4891.5 4893.0 4894.6 4937.7 4690.8 4771.4 4831.5 4860.9 4874.2 4022.8 4031.9 4034.4 4052.5 4061.4 3540.3 3585.4 3589.3 3591.7 3618.7 4195.4 4215.6 4246.3 4288.0 4289.2 4889.8 4892.4 4914.7 4920.7 4964.9 4084.4 4224.0 4230.2 4234.5 4270.1 4314.5 4349.9 4356.6 4385.8 4391.0 4651.2 4678.0 4679.7 4696.9 4714.6 4706.5 4867.2 4913.5 4919.3 4920.0 4650.5 4657.0 4657.0 4668.3 4700.1 4823.3 4824.2 4839.9 4848.0 4875.5 4788.2 4870.4 4890.0 4894.0 4947.9 4740.5 4746.2 4777.4 4799.0 4809.1 4745.4 4765.3 4767.9 4777.4 4815.0 4474.0 4643.2 4674.5 4716.6 4732.0 4772.8 4785.7 4804.6 4805.8 4846.0 4689.0 4700.0 4700.1 4718.6 4743.8 18:48:54 INFO - PROCESS | 5844 | 18:48:54 INFO - PROCESS | 5844 | [#1] ext.html Cycles:180 Average:37102.49 Median:19041.20 stddev:57876.64 (304.0%) stddev-sans-first:57973.70 18:48:54 INFO - PROCESS | 5844 | Values: 485.8 491.7 505.8 512.0 519.6 24949.4 34349.5 34989.1 35012.6 35058.5 37500.8 38017.0 38043.2 38121.2 38166.0 7687.5 7889.8 7893.5 7900.1 7903.2 7620.5 7748.0 7750.2 7771.4 7957.1 7947.2 8037.7 8040.5 8043.5 8052.0 7869.3 7910.5 7921.9 7951.9 7959.2 7713.0 7811.3 7814.5 7818.5 7969.2 37919.8 37987.4 38021.4 38192.0 38556.0 2949.4 3048.5 3094.5 3217.6 3273.3 28532.7 29076.0 29379.1 29389.3 29559.3 3418.4 3497.3 3511.2 3572.5 3649.9 215140.0 217154.0 217774.0 217955.0 218682.0 38103.6 54190.0 54493.7 54511.7 54574.5 36554.8 37067.3 37104.8 37128.4 37132.4 10855.6 11115.1 11142.2 11146.6 11161.4 8763.7 8855.3 8868.6 8881.6 8889.5 13044.5 13122.8 13341.3 13416.5 13487.2 5259.3 5390.6 5414.7 5438.9 5454.3 740.7 743.6 768.3 860.3 878.7 25512.9 26741.7 27283.2 27410.9 27478.7 863.2 907.9 920.7 925.7 955.6 13627.2 13689.8 13828.6 14069.2 14180.4 260701.0 261637.0 264044.0 264791.0 265388.0 46720.3 47494.8 47504.0 47641.0 47641.8 1098.6 1130.5 1139.5 1146.7 1156.5 23393.8 24500.3 24731.9 26515.6 26684.0 36797.0 36893.3 37135.0 37148.4 37181.6 176611.0 177215.0 178062.0 178148.0 178465.0 23783.9 28938.6 29191.7 29204.4 29499.7 33614.5 33715.3 33932.2 34468.5 34585.1 28802.0 29332.7 29511.0 29567.0 30137.7 31059.4 31699.7 31710.5 31727.2 31950.0 31847.2 32264.7 32319.0 32549.5 32552.2 27500.6 29381.1 31858.4 36267.5 36380.3 24013.6 24593.0 24608.8 25088.2 25523.1 18:48:54 INFO - PROCESS | 5844 | 18:48:54 INFO - PROCESS | 5844 | [#2] jquery.html Cycles:180 Average:20754.02 Median:4943.15 stddev:54969.53 (1112.0%) stddev-sans-first:55102.33 18:48:54 INFO - PROCESS | 5844 | Values: 324.2 338.5 341.8 341.8 350.0 14718.6 15005.3 15565.1 16527.3 16586.3 13404.7 13782.3 14036.0 14268.8 14548.3 4941.4 5074.2 5082.3 5095.3 5114.3 4917.2 4957.0 4959.1 5068.4 5080.2 4945.0 4995.2 5001.7 5006.8 5034.5 4851.2 5001.1 5003.2 5010.3 5040.2 4821.2 4838.3 4844.1 4854.6 4857.3 11192.9 11355.3 11566.4 11645.9 11699.3 1641.3 1649.3 1668.7 1695.2 1700.5 8324.4 8782.8 9058.2 9113.0 9200.9 1565.9 1763.2 1768.3 1772.8 1781.2 41840.8 49673.0 54499.7 56685.4 59167.7 8197.5 9217.6 9262.0 9388.6 9473.9 10481.4 10542.3 10552.8 10554.7 11432.8 5414.4 5508.7 5731.5 6763.8 6829.9 6325.3 6338.2 6416.1 6446.7 6461.7 4225.6 4240.9 4248.1 4256.2 4324.1 1595.6 1603.2 1628.7 1634.0 1650.7 777.6 783.6 817.1 834.4 942.7 15293.5 15633.2 15792.6 15918.0 16027.8 798.0 813.3 834.9 843.8 852.5 8888.8 8905.6 8976.6 9051.5 9186.1 292974.0 296760.0 298093.0 381969.0 385183.0 59239.4 60782.4 62741.0 70739.6 72398.6 850.7 878.7 880.2 880.5 882.0 14344.3 14344.5 14648.4 14761.8 14939.9 30934.0 31370.4 31557.0 32464.8 32615.7 44140.0 44461.8 44636.3 44700.8 45154.5 7042.9 7121.5 7166.6 7271.6 7323.1 10230.4 10848.4 11052.8 11156.3 11315.9 9572.2 9668.9 9843.6 9888.8 10368.3 7218.3 9290.2 9389.5 9636.3 9647.5 7233.7 7369.8 7475.5 7548.1 7730.9 9864.9 10121.4 10261.5 10433.6 10515.9 7048.6 7261.6 7375.4 10864.5 11175.3 18:48:54 INFO - PROCESS | 5844 | 18:48:54 INFO - PROCESS | 5844 | [#3] mootools.html Cycles:180 Average:5214.62 Median:6197.79 stddev:2758.91 (44.5%) stddev-sans-first:2750.38 18:48:54 INFO - PROCESS | 5844 | Values: 1229.1 1322.2 1322.4 1425.2 1710.0 7091.3 7216.7 7258.3 7268.6 7276.2 7076.5 7271.3 7275.8 7277.5 7282.7 1803.5 2170.5 2188.8 2212.1 2233.8 2198.2 2210.3 2212.9 2214.3 2215.0 2101.9 2212.2 2215.0 2216.6 2217.1 2154.1 2155.1 2175.8 2195.5 2211.6 2192.3 2205.4 2205.6 2209.5 2210.2 7482.3 7547.8 7554.8 7566.2 7567.5 4564.6 4664.1 4690.6 4697.1 4697.6 2852.9 2967.3 3019.8 3026.8 3031.9 913.7 928.3 930.2 941.0 956.4 10255.4 10393.3 10418.2 10435.9 10449.7 4166.9 4279.2 4338.7 4371.8 4371.8 8997.8 9018.1 9041.1 9052.9 9059.1 3790.7 4577.3 4591.9 4602.7 4608.9 3920.2 3966.8 3981.5 4009.4 4017.0 3571.4 3631.4 3659.3 3668.8 3697.3 1166.1 1171.4 1173.1 1174.0 1176.8 1173.4 1179.8 1186.5 1188.9 1200.5 7012.8 7066.9 7101.6 7104.5 7145.9 425.5 426.8 436.8 438.3 453.6 5124.8 5133.8 5134.7 5155.2 5184.3 8954.4 9077.0 9261.0 9274.3 9364.6 9096.2 9115.4 9115.5 9131.4 9211.3 7065.8 7069.9 7136.9 7156.7 7173.4 6663.5 6668.5 6705.9 6716.9 6718.6 8038.2 8079.8 8343.9 8480.1 8491.4 8398.0 8582.9 8590.5 8612.1 8748.5 5485.1 6099.1 6313.3 6668.2 6729.5 6834.9 6850.3 6864.3 6888.9 6901.2 6200.4 6393.2 6479.4 6483.4 6524.8 6199.4 6225.6 6283.6 6291.5 6382.1 6722.9 6750.1 6785.8 6796.7 6798.8 6096.5 6107.1 6248.2 6256.2 6315.5 6194.5 6196.2 6206.0 6245.9 6247.6 18:48:54 INFO - PROCESS | 5844 | 18:48:54 INFO - PROCESS | 5844 | [#4] prototype.html Cycles:180 Average:4559.83 Median:5271.62 stddev:1357.11 (25.7%) stddev-sans-first:1322.86 18:48:54 INFO - PROCESS | 5844 | Values: 307.5 312.6 315.4 315.6 316.1 5166.0 5218.4 5264.9 5302.0 5304.7 5158.3 5233.5 5257.2 5278.4 5288.0 3886.8 3910.9 4067.0 4085.8 4095.8 4051.1 4055.0 4055.3 4056.7 4068.9 4006.8 4007.4 4011.8 4019.3 4021.6 3817.0 3900.0 4008.5 4013.9 4014.2 3458.7 3459.7 3470.3 3470.5 3474.4 5033.7 5053.0 5057.0 5065.5 5073.5 4539.1 4546.4 4547.6 4548.6 4548.8 5476.9 5477.1 5486.0 5492.9 5493.7 3755.4 3758.4 3760.0 3764.6 3770.8 5608.3 5650.7 5739.7 5792.6 5794.2 3883.6 3905.7 3908.6 3914.9 3918.1 3956.6 3962.2 3965.9 3968.0 3975.6 4556.8 4558.6 4567.6 4568.2 4574.0 5501.4 5506.4 5506.9 5509.8 5510.3 1361.7 1381.6 1383.0 1385.9 1386.2 867.2 896.7 927.7 945.3 945.6 4763.4 4824.9 4852.6 4857.3 4860.6 5748.9 5764.6 5773.8 5774.1 5781.7 4874.0 4874.4 4875.4 4875.4 4885.5 3029.6 3085.3 3088.2 3090.0 3091.9 5399.6 5410.7 5412.8 5416.8 5417.6 5738.3 5896.2 5925.5 5927.9 5933.3 5447.7 5463.9 5465.7 5471.9 5473.2 5749.3 5750.2 5757.5 5763.0 5776.9 5572.2 5634.9 5635.7 5636.1 5640.7 5459.7 5464.4 5466.7 5469.6 5471.9 3751.4 3898.9 3908.1 3927.7 3933.7 5681.7 5694.8 5729.7 5761.4 5762.1 5462.1 5492.3 5492.9 5494.6 5497.6 5473.8 5489.2 5495.3 5498.0 5499.6 5383.3 5387.0 5389.2 5389.8 5393.1 5385.4 5493.5 5548.2 5548.7 5554.9 5371.3 5394.3 5394.4 5400.4 5408.7 18:48:54 INFO - PROCESS | 5844 | 18:48:54 INFO - PROCESS | 5844 | [#5] yui.html Cycles:180 Average:12132.29 Median:22757.70 stddev:13724.67 (60.3%) stddev-sans-first:13735.87 18:48:54 INFO - PROCESS | 5844 | Values: 603.5 720.3 740.7 743.4 755.2 11930.5 11945.3 12036.3 12103.7 12103.9 11582.7 11680.9 11688.5 11710.4 11713.0 613.6 764.7 783.6 809.1 810.6 792.3 795.8 799.0 799.4 799.5 848.9 852.8 853.5 854.0 854.0 640.2 828.1 843.7 844.4 845.0 619.7 624.1 624.4 625.3 625.5 11694.3 11721.1 11760.5 11814.0 11822.9 10287.3 10873.5 11470.3 11496.3 11533.7 9476.5 9529.9 9627.5 9705.8 9731.0 2974.1 2996.1 3022.0 3055.8 3091.9 41333.4 41852.6 42362.6 42390.2 42613.6 9437.3 9530.4 9552.4 9600.3 9646.6 16946.5 17129.7 17130.1 17133.8 17148.5 6154.9 6314.5 6363.2 6400.8 6580.5 3420.3 3432.2 3520.5 3551.4 3582.9 2523.9 2624.6 2632.1 2692.9 2727.5 445.7 523.7 532.2 536.0 537.9 522.3 553.3 566.3 580.5 593.2 7676.3 7721.8 7937.3 7965.9 8053.2 475.4 488.9 596.3 598.8 600.0 3311.2 3423.7 3728.8 3779.3 3869.3 49486.5 49816.8 50393.0 50521.5 50526.5 43116.6 44613.3 44654.6 44771.3 45040.0 39216.0 39392.8 40477.8 40505.8 40768.2 7730.9 8033.0 8323.7 8357.2 8381.2 28304.6 28368.6 28801.1 30514.7 31454.8 34781.7 34874.8 38123.6 38213.6 38761.6 9818.6 9933.3 9940.3 10000.4 10000.6 11419.3 11454.2 11498.1 11603.7 11816.5 8523.5 9396.2 10666.2 10893.4 11036.9 10502.2 10525.9 10737.0 10784.6 11017.1 10477.7 10647.3 10693.5 10694.0 10896.9 8260.5 8434.5 8509.4 8520.8 8886.2 7322.3 7781.7 7902.0 7949.6 8101.8 18:48:54 INFO - PROCESS | 5844 | -------- Summary: end -------- 18:48:54 INFO - PROCESS | 5844 | 18:48:55 INFO - TEST-INFO | 5844: exit 0 18:48:55 INFO - TEST-OK | dromaeo_css | took 1117503ms 18:48:55 INFO - TEST-START | kraken 18:48:55 INFO - operating with platform_type : linux_ 18:48:55 INFO - Initialising browser for kraken test... 18:48:55 INFO - TEST-INFO | started process 6024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp55xdAn/profile http://localhost:46528/getInfo.html) 18:48:59 INFO - PROCESS | 6024 | __metrics Screen width/height:1600/1200 18:48:59 INFO - PROCESS | 6024 | colorDepth:24 18:48:59 INFO - PROCESS | 6024 | Browser inner width/height: 1024/697 18:48:59 INFO - PROCESS | 6024 | __metrics 18:49:00 ERROR - PROCESS | 6024 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:49:00 INFO - PROCESS | 6024 | 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. 18:49:01 INFO - TEST-INFO | 6024: exit 0 18:49:01 INFO - Browser initialized. 18:49:01 INFO - Running cycle 1/1 for kraken test... 18:49:01 INFO - TEST-INFO | started process 6109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp55xdAn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:49:13 INFO - PROCESS | 6109 | RSS: Main: 154071040 18:49:13 INFO - PROCESS | 6109 | 18:49:16 INFO - PROCESS | 6109 | Cycle 1(1): loaded http://localhost:46528/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46528/tests/kraken/driver.html?testName=audio-beat-detection) 18:49:16 INFO - PROCESS | 6109 | RSS: Main: 194990080 18:49:16 INFO - PROCESS | 6109 | 18:49:19 INFO - PROCESS | 6109 | Cycle 1(1): loaded http://localhost:46528/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46528/tests/kraken/driver.html?testName=audio-dft) 18:49:20 INFO - PROCESS | 6109 | RSS: Main: 185335808 18:49:20 INFO - PROCESS | 6109 | 18:49:23 INFO - PROCESS | 6109 | Cycle 1(1): loaded http://localhost:46528/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46528/tests/kraken/driver.html?testName=audio-fft) 18:49:23 INFO - PROCESS | 6109 | RSS: Main: 171393024 18:49:23 INFO - PROCESS | 6109 | 18:49:25 INFO - PROCESS | 6109 | Cycle 1(1): loaded http://localhost:46528/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46528/tests/kraken/driver.html?testName=audio-oscillator) 18:49:26 INFO - PROCESS | 6109 | RSS: Main: 173146112 18:49:26 INFO - PROCESS | 6109 | 18:49:28 INFO - PROCESS | 6109 | Cycle 1(1): loaded http://localhost:46528/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46528/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:49:29 INFO - PROCESS | 6109 | RSS: Main: 174866432 18:49:29 INFO - PROCESS | 6109 | 18:49:32 INFO - PROCESS | 6109 | Cycle 1(1): loaded http://localhost:46528/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46528/tests/kraken/driver.html?testName=imaging-darkroom) 18:49:32 INFO - PROCESS | 6109 | RSS: Main: 176377856 18:49:32 INFO - PROCESS | 6109 | 18:49:36 INFO - PROCESS | 6109 | Cycle 1(1): loaded http://localhost:46528/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46528/tests/kraken/driver.html?testName=imaging-desaturate) 18:49:37 INFO - PROCESS | 6109 | RSS: Main: 176013312 18:49:37 INFO - PROCESS | 6109 | 18:49:39 INFO - PROCESS | 6109 | Cycle 1(1): loaded http://localhost:46528/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46528/tests/kraken/driver.html?testName=json-parse-financial) 18:49:40 INFO - PROCESS | 6109 | RSS: Main: 177745920 18:49:40 INFO - PROCESS | 6109 | 18:49:42 INFO - PROCESS | 6109 | Cycle 1(1): loaded http://localhost:46528/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46528/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:49:42 INFO - PROCESS | 6109 | RSS: Main: 186138624 18:49:42 INFO - PROCESS | 6109 | 18:49:44 INFO - PROCESS | 6109 | Cycle 1(1): loaded http://localhost:46528/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46528/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:49:45 INFO - PROCESS | 6109 | RSS: Main: 182444032 18:49:45 INFO - PROCESS | 6109 | 18:49:47 INFO - PROCESS | 6109 | Cycle 1(1): loaded http://localhost:46528/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46528/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:49:48 INFO - PROCESS | 6109 | RSS: Main: 192126976 18:49:48 INFO - PROCESS | 6109 | 18:49:50 INFO - PROCESS | 6109 | Cycle 1(1): loaded http://localhost:46528/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:49:51 INFO - PROCESS | 6109 | RSS: Main: 198766592 18:49:51 INFO - PROCESS | 6109 | 18:49:53 INFO - PROCESS | 6109 | Cycle 1(1): loaded http://localhost:46528/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:49:54 INFO - PROCESS | 6109 | RSS: Main: 197144576 18:49:54 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | Cycle 1(1): loaded http://localhost:46528/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46528/tests/kraken/driver.html?testName=ai-astar) 18:49:56 INFO - PROCESS | 6109 | RSS: Main: 258203648 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | __start_tp_report 18:49:56 INFO - PROCESS | 6109 | _x_x_mozilla_page_load 18:49:56 INFO - PROCESS | 6109 | _x_x_mozilla_page_load_details 18:49:56 INFO - PROCESS | 6109 | |i|pagename|runs| 18:49:56 INFO - PROCESS | 6109 | |0;ai-astar;111;113;107;112;114;113;103;113;113;113 18:49:56 INFO - PROCESS | 6109 | |1;audio-beat-detection;160;133;151;171;143;160;157;134;177;134 18:49:56 INFO - PROCESS | 6109 | |2;audio-dft;161;161;160;160;161;162;161;160;161;161 18:49:56 INFO - PROCESS | 6109 | |3;audio-fft;75;73;101;93;75;74;74;112;92;77 18:49:56 INFO - PROCESS | 6109 | |4;audio-oscillator;96;96;149;95;95;95;151;96;95;130 18:49:56 INFO - PROCESS | 6109 | |5;imaging-gaussian-blur;117;116;116;117;118;117;117;118;118;117 18:49:56 INFO - PROCESS | 6109 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 18:49:56 INFO - PROCESS | 6109 | |7;imaging-desaturate;97;96;96;96;97;97;97;96;97;96 18:49:56 INFO - PROCESS | 6109 | |8;json-parse-financial;68;68;68;69;69;69;67;77;66;66 18:49:56 INFO - PROCESS | 6109 | |9;json-stringify-tinderbox;80;71;70;71;70;70;70;70;71;71 18:49:56 INFO - PROCESS | 6109 | |10;stanford-crypto-aes;84;91;84;82;83;84;84;84;83;83 18:49:56 INFO - PROCESS | 6109 | |11;stanford-crypto-ccm;120;122;122;125;129;121;129;120;121;121 18:49:56 INFO - PROCESS | 6109 | |12;stanford-crypto-pbkdf2;151;139;149;150;153;144;149;148;137;141 18:49:56 INFO - PROCESS | 6109 | |13;stanford-crypto-sha256-iterative;76;71;80;71;72;73;70;70;70;71 18:49:56 INFO - PROCESS | 6109 | __end_tp_report 18:49:56 INFO - PROCESS | 6109 | __start_cc_report 18:49:56 INFO - PROCESS | 6109 | _x_x_mozilla_cycle_collect,1140 18:49:56 INFO - PROCESS | 6109 | __end_cc_report 18:49:56 INFO - PROCESS | 6109 | __startTimestamp1457578196484__endTimestamp 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | ------- Summary: start ------- 18:49:56 INFO - PROCESS | 6109 | Number of tests: 14 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | [#0] ai-astar Cycles:10 Average:111.20 Median:113.00 stddev:3.49 (3.1%) stddev-sans-first:3.70 18:49:56 INFO - PROCESS | 6109 | Values: 111.0 113.0 107.0 112.0 114.0 113.0 103.0 113.0 113.0 113.0 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:158.50 stddev:15.74 (9.9%) stddev-sans-first:16.43 18:49:56 INFO - PROCESS | 6109 | Values: 160.0 133.0 151.0 171.0 143.0 160.0 157.0 134.0 177.0 134.0 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 18:49:56 INFO - PROCESS | 6109 | Values: 161.0 161.0 160.0 160.0 161.0 162.0 161.0 160.0 161.0 161.0 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | [#3] audio-fft Cycles:10 Average:84.60 Median:75.00 stddev:13.93 (18.6%) stddev-sans-first:14.34 18:49:56 INFO - PROCESS | 6109 | Values: 75.0 73.0 101.0 93.0 75.0 74.0 74.0 112.0 92.0 77.0 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:95.00 stddev:23.78 (25.0%) stddev-sans-first:24.69 18:49:56 INFO - PROCESS | 6109 | Values: 96.0 96.0 149.0 95.0 95.0 95.0 151.0 96.0 95.0 130.0 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 18:49:56 INFO - PROCESS | 6109 | Values: 117.0 116.0 116.0 117.0 118.0 117.0 117.0 118.0 118.0 117.0 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 18:49:56 INFO - PROCESS | 6109 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 18:49:56 INFO - PROCESS | 6109 | Values: 97.0 96.0 96.0 96.0 97.0 97.0 97.0 96.0 97.0 96.0 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | [#8] json-parse-financial Cycles:10 Average:68.70 Median:68.50 stddev:3.13 (4.6%) stddev-sans-first:3.31 18:49:56 INFO - PROCESS | 6109 | Values: 68.0 68.0 68.0 69.0 69.0 69.0 67.0 77.0 66.0 66.0 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.00 stddev:3.06 (4.3%) stddev-sans-first:0.53 18:49:56 INFO - PROCESS | 6109 | Values: 80.0 71.0 70.0 71.0 70.0 70.0 70.0 70.0 71.0 71.0 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:2.49 (3.0%) stddev-sans-first:2.64 18:49:56 INFO - PROCESS | 6109 | Values: 84.0 91.0 84.0 82.0 83.0 84.0 84.0 84.0 83.0 83.0 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:122.00 stddev:3.46 (2.8%) stddev-sans-first:3.50 18:49:56 INFO - PROCESS | 6109 | Values: 120.0 122.0 122.0 125.0 129.0 121.0 129.0 120.0 121.0 121.0 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.10 Median:149.00 stddev:5.49 (3.7%) stddev-sans-first:5.53 18:49:56 INFO - PROCESS | 6109 | Values: 151.0 139.0 149.0 150.0 153.0 144.0 149.0 148.0 137.0 141.0 18:49:56 INFO - PROCESS | 6109 | 18:49:56 INFO - PROCESS | 6109 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:71.50 stddev:3.24 (4.5%) stddev-sans-first:3.16 18:49:56 INFO - PROCESS | 6109 | Values: 76.0 71.0 80.0 71.0 72.0 73.0 70.0 70.0 70.0 71.0 18:49:56 INFO - PROCESS | 6109 | -------- Summary: end -------- 18:49:56 INFO - PROCESS | 6109 | 18:49:57 INFO - TEST-INFO | 6109: exit 0 18:49:57 INFO - TEST-OK | kraken | took 62429ms 18:49:57 INFO - SUITE-END | took 1179s 18:49:57 INFO - Completed test suite (00:19:40) 18:49:57 INFO - javascript benchmark 18:49:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2588.7670109690125, 2684.154491335228, 2685.597160425937, 2693.070890542762, 2712.742289482499, 4497.370368148462, 4601.677882548214, 4609.562091601301, 4636.744979026153, 4652.255639097741, 4414.801333939972, 4558.1567410029165, 4629.259318509039, 4645.233536466488, 4646.767661616923, 4144.91710165798, 4218.831246750126, 4241.830326786932, 4310.590493903074, 4362.890927726817, 4107.301758701028, 4293.162833247518, 4329.567043295661, 4344.4786625604975, 4347.521772605027, 4225.8520951766695, 4249.426327445817, 4258.169656916903, 4293.613574778254, 4320.891977700551, 4205.87382378526, 4217.325227963542, 4228.725132866384, 4237.279662457389, 4259.0, 4110.897227569305, 4190.120074784299, 4215.936760948588, 4222.873313800591, 4258.339957306623, 4469.620082292977, 4522.592966632986, 4538.72767633943, 4541.772911354452, 4583.060472603109, 4921.384826896638, 4921.680090794087, 4927.581155601778, 4928.7535623219055, 4928.926066108976, 4746.43042834862, 4856.223004319328, 4937.876553086202, 4980.228064649985, 4997.875053123665, 4539.024109816405, 4551.658625603093, 4565.223911934979, 4568.223402021665, 4594.977025114887, 4980.9252861207115, 4985.202367621163, 4986.825461108844, 4987.925181122286, 5027.371578552681, 4612.07758448305, 4730.314104454835, 4788.1381351356395, 4852.539008794159, 4854.368932038812, 4919.532644398776, 4919.827806026772, 4937.2982090192945, 4941.110600092018, 4972.378452693413, 4864.294677271776, 4891.5353041461, 4893.0, 4894.559489645949, 4937.679050861682, 4690.7654617269, 4771.379720636364, 4831.541003604652, 4860.902781944412, 4874.2444921037295, 4022.818973146157, 4031.91936161281, 4034.4150098236178, 4052.452918855917, 4061.411095391152, 3540.291941611688, 3585.372559802024, 3589.335972845032, 3591.712662986955, 3618.692411145082, 4195.370694395865, 4215.557366476476, 4246.299360605527, 4288.0, 4289.1636130954785, 4889.779959901742, 4892.363992680928, 4914.729689867092, 4920.6555541111775, 4964.925526117111, 4084.36692312692, 4223.978880105641, 4230.175115852379, 4234.491860976641, 4270.12462445198, 4314.50383205929, 4349.869503914888, 4356.607905288539, 4385.824567017284, 4390.978045109818, 4651.162790697707, 4677.953220467888, 4679.742614156254, 4696.9060618787435, 4714.5992590630185, 4706.505816889315, 4867.172580661225, 4913.533214344631, 4919.262110683426, 4920.040592084652, 4650.465196502446, 4656.976715116402, 4656.976715116402, 4668.276417155346, 4700.106979673851, 4823.348847905488, 4824.155772739827, 4839.903201936012, 4848.0, 4875.512448755097, 4788.186008378653, 4870.4155501340065, 4889.951100488949, 4894.0, 4947.925781113358, 4740.549647783455, 4746.240601503743, 4777.355057067391, 4799.0, 4809.134355815847, 4745.406824146981, 4765.309030190672, 4767.904641907212, 4777.402824646919, 4815.036992601564, 4473.977630111959, 4643.187442197669, 4674.462436819809, 4716.646251531218, 4732.02993386348, 4772.761361931959, 4785.736784476748, 4804.591609713214, 4805.783739731651, 4845.95154048455, 4688.953110468988, 4700.0, 4700.083483720641, 4718.5753282203395, 4743.786529606107], "unit": "score", "name": "dojo.html", "value": 4499.866049786836}, {"lowerIsBetter": false, "replicates": [485.7935377464579, 491.6558409113619, 505.7648193589981, 512.0450360078454, 519.6359556165066, 24949.376265593346, 34349.48475772862, 34989.125271868215, 35012.64987350126, 35058.47412288811, 37500.81249593748, 38017.0, 38043.23913521735, 38121.23757524848, 38166.0, 7687.461877668579, 7889.802754931144, 7893.486923349992, 7900.091489478697, 7903.249191326815, 7620.504667196615, 7748.031496062992, 7750.224977502261, 7771.417143714216, 7957.084935232436, 7947.205279472064, 8037.678492860307, 8040.517568945853, 8043.477173983672, 8051.9597402012905, 7869.252421020023, 7910.52536847791, 7921.920780792176, 7951.920480795205, 7959.164287749761, 7712.961435192844, 7811.296983271476, 7814.452988290822, 7818.530888146673, 7969.242921922408, 37919.81040094782, 37987.430188547194, 38021.42967855484, 38192.0, 38556.0, 2949.3658863344485, 3048.4512787698204, 3094.520349345855, 3217.6138863336314, 3273.29624130813, 28532.714672853213, 29076.0, 29379.118626441243, 29389.265268368246, 29559.26101847471, 3418.4017796885696, 3497.266675265146, 3511.157322242669, 3572.5355703758346, 3649.8905032849057, 215140.0, 217154.0, 217774.0, 217955.0, 218682.0, 38103.618963810564, 54190.0, 54493.727531362885, 54511.72744136254, 54574.454255457735, 36554.80671159686, 37067.25865482675, 37104.80532725421, 37128.44307335392, 37132.44301335482, 10855.588773459558, 11115.055220306365, 11142.220044596801, 11146.554137834559, 11161.441927903572, 8763.737087887373, 8855.291576673852, 8868.600912958933, 8881.555922203865, 8889.511076890833, 13044.54344097952, 13122.803157952638, 13341.332933353293, 13416.530421435204, 13487.190768553919, 5259.263703081571, 5390.649607775482, 5414.675119492843, 5438.945610543844, 5454.290942177491, 740.714824792448, 743.6319022083995, 768.277818850279, 860.2773670117132, 878.7407714724171, 25512.872435638074, 26741.732582674314, 27283.181504554894, 27410.86294568554, 27478.725212747617, 863.2489733931394, 907.8592818113203, 920.7053742802239, 925.6528801699362, 955.603424578806, 13627.182369057888, 13689.794653080211, 13828.585142445743, 14069.226192559303, 14180.432782688784, 260701.0, 261637.0, 264044.0, 264791.0, 265388.0, 46720.299195512096, 47494.76252618784, 47504.0, 47641.0, 47641.761791191515, 1098.6045023791428, 1130.5138790320077, 1139.5043156227068, 1146.7133216695827, 1156.5373850459714, 23393.76606233984, 24500.274711552443, 24731.876340618182, 26515.60226596564, 26684.0, 36797.0, 36893.26213475662, 37135.0, 37148.44277335896, 37181.62818371782, 176611.0, 177215.0, 178062.0, 178148.0, 178465.0, 23783.881080594485, 28938.565921511614, 29191.708082919748, 29204.415911681222, 29499.705002949697, 33614.49578256377, 33715.325693486484, 33932.151696206805, 34468.48297275493, 34585.1353716149, 28802.0, 29332.70667293385, 29511.0, 29567.0, 30137.69862301349, 31059.37881242408, 31699.683003170594, 31710.524342134424, 31727.206819829687, 31950.0, 31847.203819904687, 32264.67735322617, 32319.030429087165, 32549.511757324133, 32552.186195345304, 27500.58749118725, 29381.11856644304, 31858.36283274275, 36267.45598816073, 36380.27239455143, 24013.639795402734, 24593.0, 24608.75391246136, 25088.247352579452, 25523.106691265715], "unit": "score", "name": "ext.html", "value": 15647.135200783756}, {"lowerIsBetter": false, "replicates": [324.18952618453864, 338.4787427361863, 341.8275315667261, 341.84616922384936, 350.0269251480884, 14718.558443246706, 15005.324760385782, 15565.066096034232, 16527.256273467694, 16586.25361858716, 13404.731905361887, 13782.310884455786, 14036.0, 14268.785968210484, 14548.345324460399, 4941.357623508948, 5074.213496907967, 5082.263071854579, 5095.312132862072, 5114.2584325273, 4917.164082106051, 4956.975215123919, 4959.132151873426, 5068.4424713281505, 5080.161773307418, 4944.950550494503, 4995.175795993657, 5001.6998980061135, 5006.799728010875, 5034.496550344955, 4851.248056551205, 5001.099802035632, 5003.174476211439, 5010.273510340999, 5040.193569028937, 4821.156297647897, 4838.298446725205, 4844.128056949748, 4854.611631069506, 4857.295692124658, 11192.944035279854, 11355.261907975955, 11566.42167891602, 11645.883541164565, 11699.2980421175, 1641.3434626149517, 1649.2990479046357, 1668.7413450915005, 1695.2456157010135, 1700.5408539694338, 8324.417290789646, 8782.780430489225, 9058.23005044572, 9112.954435227848, 9200.861987070199, 1565.9451919182775, 1763.1713094845402, 1768.2838450427598, 1772.7961284452194, 1781.1806568978286, 41840.790796045825, 49673.0, 54499.72750136224, 56685.43314566843, 59167.70416147935, 8197.549134797524, 9217.585208665627, 9262.0, 9388.624455021723, 9473.90526094744, 10481.423521706227, 10542.314749541256, 10552.841707374395, 10554.683359499073, 11432.828507572392, 5414.431484694129, 5508.724563771795, 5731.541476681856, 6763.797086087426, 6829.931700683029, 6325.272593651789, 6338.207724034496, 6416.101745755598, 6446.677666116675, 6461.741530338828, 4225.57744225575, 4240.851570195028, 4248.065425606362, 4256.212600668886, 4324.070324880166, 1595.6409807793154, 1603.2384617306918, 1628.7149748793913, 1634.0, 1650.6616143690514, 777.6150805351388, 783.6316931042401, 817.1011886924335, 834.3867257565685, 942.6936245720168, 15293.464728734441, 15633.218339083, 15792.60518487047, 15918.0, 16027.759583606256, 797.968081276754, 813.259933460548, 834.9499030058216, 843.7595285343771, 852.4586887326468, 8888.822223555493, 8905.643774249087, 8976.551172441352, 9051.456912585267, 9186.08139186076, 292974.0, 296760.0, 298093.0, 381969.0, 385183.0, 59239.40760592339, 60782.39217607856, 62741.0, 70739.64630176817, 72398.63800680963, 850.6980022092192, 878.7495563764296, 880.2473884828507, 880.528917029399, 882.0429833630454, 14344.282785860456, 14344.49794257196, 14648.414063437343, 14761.778573321624, 14939.850601493847, 30934.0, 31370.372592548476, 31557.0, 32464.83767581147, 32615.673843261262, 44140.0, 44461.77769111134, 44636.33045504255, 44700.77649611731, 45154.54845451503, 7042.859142817218, 7121.537100088478, 7166.570005799668, 7271.636418179176, 7323.084614423197, 10230.386176829117, 10848.40333781618, 11052.778944421227, 11156.274842135235, 11315.886841131483, 9572.160981800957, 9668.854967175357, 9843.60625574969, 9888.802223955337, 10368.274220804773, 7218.314260145278, 9290.210332121846, 9389.48357840298, 9636.325457217927, 9647.469389183661, 7233.674484648098, 7369.77890663281, 7475.514091584029, 7548.056492938383, 7730.92269077302, 9864.85202721974, 10121.392716437038, 10261.538230779484, 10433.634822781167, 10515.894841051491, 7048.577085374894, 7261.636918153966, 7375.37309328713, 10864.511097000495, 11175.329480231212], "unit": "score", "name": "jquery.html", "value": 7364.452604521645}, {"lowerIsBetter": false, "replicates": [1229.0659099084694, 1322.1538215542053, 1322.352047496727, 1425.2374979386032, 1709.9999999999993, 7091.290870912906, 7216.711331546739, 7258.274172582739, 7268.563886166827, 7276.16324122726, 7076.469264805148, 7271.309225623558, 7275.818104547389, 7277.454190935675, 7282.745103921364, 1803.4769916724135, 2170.5116348821466, 2188.7701791311883, 2212.126210146991, 2233.7766223377694, 2198.1976578548874, 2210.270610698474, 2212.9114835406563, 2214.3135627955303, 2214.966775498369, 2101.8528702990798, 2212.23677831148, 2214.9778502215013, 2216.5899308627954, 2217.0688310909377, 2154.095279982403, 2155.073318473056, 2175.815055720258, 2195.5279614882716, 2211.579799838026, 2192.2655910270078, 2205.404540773998, 2205.6470964645578, 2209.5359974405396, 2210.237468073512, 7482.326590606872, 7547.773566793005, 7554.811129721746, 7566.205548417392, 7567.545947243183, 4564.6348292136545, 4664.090502352043, 4690.554397332248, 4697.131030759287, 4697.553732395417, 2852.9001484947926, 2967.317516971109, 3019.849007549614, 3026.772992025607, 3031.924201894948, 913.7441516375426, 928.2713070239829, 930.2418528898926, 940.9529523523796, 956.3735753081743, 10255.384676919408, 10393.324433911772, 10418.218633602435, 10435.895641043568, 10449.738756531071, 4166.8749937501925, 4279.16556271524, 4338.717983331137, 4371.78141092944, 4371.846985355497, 8997.820043599091, 9018.09819018093, 9041.141091596288, 9052.909470905339, 9059.139381758723, 3790.7156963227867, 4577.313402989578, 4591.862244132614, 4602.654800889946, 4608.861734147981, 3920.196359746245, 3966.7619942803526, 3981.5421226558738, 4009.4386785850006, 4016.9756712038243, 3571.4464258040043, 3631.3645112105805, 3659.3047321009453, 3668.798216098087, 3697.334479793663, 1166.1370585766642, 1171.3557543351124, 1173.0732721150196, 1173.9706507337385, 1176.7822952753768, 1173.436750359832, 1179.8466199394024, 1186.543180875352, 1188.857337119534, 1200.5317926008688, 7012.7545535906, 7066.929330706627, 7101.644917754092, 7104.538205016657, 7145.857082858418, 425.4787884841045, 426.83566826771914, 436.8383698031749, 438.2680922858833, 453.61896007353323, 5124.8206312778875, 5133.845984620468, 5134.666246693953, 5155.200943853709, 5184.326037615161, 8954.417962832395, 9076.954615227014, 9260.953695231616, 9274.30442716799, 9364.62541498346, 9096.181343678969, 9115.407498512575, 9115.544222788834, 9131.360804743605, 9211.263098952068, 7065.752698655522, 7069.939509073577, 7136.857262854714, 7156.713731450788, 7173.426125910019, 6663.466922646274, 6668.466522678077, 6705.865882682221, 6716.932830671631, 6718.630475323904, 8038.236367545074, 8079.83840323202, 8343.874841877256, 8480.109588493366, 8491.448055876595, 8398.034226064081, 8582.884225050953, 8590.527520986405, 8612.095729948265, 8748.518831464076, 5485.122380419114, 6099.11562823397, 6313.337099604475, 6668.166479190101, 6729.461643068445, 6834.897476537756, 6850.314968503109, 6864.347886950732, 6888.896666549906, 6901.1718593769065, 6200.410960958701, 6393.200849893763, 6479.449246814073, 6483.384078512534, 6524.771632992823, 6199.380061993765, 6225.564210505221, 6283.560150789401, 6291.465225455888, 6382.138411314413, 6722.932770672426, 6750.0887380205, 6785.796426107225, 6796.728130874907, 6798.796036118924, 6096.451319381277, 6107.053406721965, 6248.187735594343, 6256.249250090018, 6315.4947604192475, 6194.473469755121, 6196.194494715838, 6205.9760139576465, 6245.9063114052415, 6247.5939063960695], "unit": "score", "name": "mootools.html", "value": 4195.435631256486}, {"lowerIsBetter": false, "replicates": [307.4818930102777, 312.55617023826164, 315.427499089153, 315.58342987256816, 316.05972232607985, 5165.974170129149, 5218.425973142956, 5264.868378290545, 5301.973490132549, 5304.681719096857, 5158.329417175762, 5233.502817232356, 5257.1851363038695, 5278.3665960084745, 5288.021715982536, 3886.7667939923554, 3910.882673519799, 4067.0, 4085.775282359469, 4095.8156882940266, 4051.0885050863467, 4054.97972510137, 4055.3308704063943, 4056.71602987791, 4068.8575899843513, 4006.819693113817, 4007.3588225883864, 4011.819468123927, 4019.336809426441, 4021.5978402159844, 3816.999999999986, 3899.961000389988, 4008.4767788240574, 4013.9197216055513, 4014.2172276406113, 3458.6887180153653, 3459.705924996378, 3470.323286959044, 3470.4794280857823, 3474.4267195912644, 5033.748312584356, 5053.0, 5057.0, 5065.493450654942, 5073.492650734897, 4539.0694907543875, 4546.408966834323, 4547.567981041796, 4548.613367863735, 4548.7725613719185, 5476.890462190774, 5477.096279113942, 5486.0, 5492.945070549284, 5493.670379777226, 3755.4366844973474, 3758.4362345648096, 3759.962400376016, 3764.5670747864074, 3770.830312635938, 5608.298962629671, 5650.745716442729, 5739.655620662774, 5792.594518383715, 5794.159846822229, 3883.6310550497656, 3905.6680182184264, 3908.6286802753693, 3914.9021274468364, 3918.0988372674447, 3956.624120708528, 3962.2471730371135, 3965.900852478711, 3968.0, 3975.6024397560013, 4556.84051058218, 4558.566936141061, 4567.566081222279, 4568.1548913451115, 4573.977130114328, 5501.394846566875, 5506.421825708243, 5506.91739623906, 5509.834704958857, 5510.256115424447, 1361.6527785414655, 1381.5717127690448, 1382.979255311171, 1385.9307034648227, 1386.2375693368606, 867.1805144138855, 896.6547879066476, 927.7448701606977, 945.2863088368238, 945.6312038305067, 4763.404574428197, 4824.890275236715, 4852.636052296092, 4857.271409288635, 4860.635452341088, 5748.9425105748405, 5764.596478246483, 5773.797917072966, 5774.105013722879, 5781.682007489544, 4874.000829829876, 4874.36633237684, 4875.390576177978, 4875.439324477659, 4885.5358740919555, 3029.606151200374, 3085.2595377109333, 3088.1507585414192, 3090.0420869530067, 3091.8608662610236, 5399.6490228135835, 5410.729463526808, 5412.782124022064, 5416.810411635653, 5417.59368047398, 5738.282714660668, 5896.233489646319, 5925.525957923442, 5927.851803704942, 5933.3473317934995, 5447.700376479253, 5463.863403414946, 5465.699386533699, 5471.863203419946, 5473.17902314656, 5749.252597162509, 5750.194972703741, 5757.539396848326, 5763.049096898964, 5776.913346299725, 5572.164175373727, 5634.943650563442, 5635.690037048002, 5636.126400407943, 5640.661560306395, 5459.69971651563, 5464.398916119303, 5466.671999680032, 5469.617126801086, 5471.945280547144, 3751.4185301278344, 3898.8830335089992, 3908.081600823747, 3927.7446965947124, 3933.685305175522, 5681.715914204356, 5694.800681976111, 5729.656220626775, 5761.39505351932, 5762.078067509178, 5462.126059830408, 5492.286002819608, 5492.862678433071, 5494.587905907153, 5497.560195184456, 5473.781048758005, 5489.231507588861, 5495.258140151188, 5497.972510137423, 5499.642523235977, 5383.327084114486, 5387.0, 5389.218563308376, 5389.83830485086, 5393.137098064448, 5385.353757549119, 5493.478119578634, 5548.195511650869, 5548.667079975215, 5554.861128471821, 5371.328583927009, 5394.271773310553, 5394.352677678704, 5400.432954539717, 5408.675479471244], "unit": "score", "name": "prototype.html", "value": 4124.910650746683}, {"lowerIsBetter": false, "replicates": [603.4568888000796, 720.3264947274299, 740.6815069520107, 743.4275607782006, 755.2145768400864, 11930.463129159187, 11945.283283003026, 12036.338001409918, 12103.697407564816, 12103.878961210396, 11582.710432239199, 11680.941595292034, 11688.47401866916, 11710.355930423844, 11713.0, 613.5521069619181, 764.7285213749122, 783.5690370296343, 809.0938149272794, 810.6392655268407, 792.2750683124963, 795.8090058386003, 799.0092285565886, 799.4084377560592, 799.4963173200875, 848.9023762267357, 852.799592095857, 853.4793775796759, 853.995730021349, 854.0221446443818, 640.2253273539023, 828.0808302783905, 843.6541018182515, 844.3625063077368, 845.0366582096415, 619.6653806944245, 624.1449214576014, 624.3600309682566, 625.327772644409, 625.4683519008852, 11694.2983420995, 11721.062315014779, 11760.470778814888, 11814.0, 11822.88177118235, 10287.279890407675, 10873.510692018877, 11470.311781293065, 11496.252743571642, 11533.653990380219, 9476.526173691287, 9529.904700952971, 9627.518624068769, 9705.805883882353, 9730.951345243298, 2974.107767669712, 2996.0562422836956, 3021.9546706799415, 3055.8319292438905, 3091.8608662610236, 41333.379999300036, 41852.58147418517, 42362.576374236174, 42390.15219695589, 42613.57386426158, 9437.292203084658, 9530.380525265835, 9552.42685438876, 9600.32797704154, 9646.565904534313, 16946.491605251616, 17129.657406852042, 17130.143492825307, 17133.82866171322, 17148.485545433658, 6154.9384506154365, 6314.526410519229, 6363.204599425072, 6400.775972840928, 6580.539362244693, 3420.3330350581396, 3432.22774875656, 3520.4543295789194, 3551.396262635358, 3582.946255806165, 2523.873806309677, 2624.6325514427995, 2632.0524611139977, 2692.8788204530842, 2727.5090483712725, 445.66797735687123, 523.7014901506182, 532.2256117349248, 536.0351367538493, 537.9408265090836, 522.2844702757171, 553.3000754046135, 566.3289002532013, 580.5413723158741, 593.2169536212244, 7676.309132178131, 7721.806954826175, 7937.285644292041, 7965.8805117923275, 8053.154418785943, 475.40099474662173, 488.85334399679954, 596.2695697770197, 598.7874304621884, 599.9850003749854, 3311.205310725457, 3423.6747508987105, 3728.832202550892, 3779.3197224499854, 3869.2648396804516, 49486.50513494891, 49816.75091624519, 50393.0, 50521.49478505168, 50526.49473505291, 43116.56883431188, 44613.33080003803, 44654.55345446569, 44771.328430073576, 45040.0, 39216.0, 39392.80303598521, 40477.79761101176, 40505.797471012454, 40768.18463630711, 7730.884036739341, 8033.0, 8323.667053318042, 8357.247847693738, 8381.203785640355, 28304.575431368135, 28368.574471382533, 28801.135965921058, 30514.694853051184, 31454.842725786224, 34781.65218347784, 34874.82562587171, 38123.61876381201, 38213.61786382212, 38761.6123838758, 9818.558164882741, 9933.255005874444, 9940.304178707422, 10000.449975251431, 10000.649977250761, 11419.31484110956, 11454.198206125824, 11498.13763967689, 11603.6518904433, 11816.468258928197, 8523.531205783742, 9396.248300136109, 10666.200034997251, 10893.400862952614, 11036.947915470457, 10502.159827213653, 10525.894741052798, 10737.04821082507, 10784.568617255221, 11017.1186305097, 10477.68566942993, 10647.30792498485, 10693.518791654238, 10694.0, 10896.945515272373, 8260.504369737835, 8434.536100514286, 8509.404341696269, 8520.786980325542, 8886.200241978253, 7322.267773222635, 7781.727639532589, 7901.960490197513, 7949.562774047483, 8101.797455063671], "unit": "score", "name": "yui.html", "value": 5662.45280999687}], "name": "dromaeo_css", "value": 6086.046667026872}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 112.0, 114.0, 113.0, 103.0, 113.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [160.0, 133.0, 151.0, 171.0, 143.0, 160.0, 157.0, 134.0, 177.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 152.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 161.0, 162.0, 161.0, 160.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 101.0, 93.0, 75.0, 74.0, 74.0, 112.0, 92.0, 77.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 149.0, 95.0, 95.0, 95.0, 151.0, 96.0, 95.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 67.0, 77.0, 66.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 68.7}, {"lowerIsBetter": true, "replicates": [80.0, 71.0, 70.0, 71.0, 70.0, 70.0, 70.0, 70.0, 71.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.4}, {"lowerIsBetter": true, "replicates": [84.0, 91.0, 84.0, 82.0, 83.0, 84.0, 84.0, 84.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [120.0, 122.0, 122.0, 125.0, 129.0, 121.0, 129.0, 120.0, 121.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [151.0, 139.0, 149.0, 150.0, 153.0, 144.0, 149.0, 148.0, 137.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.1}, {"lowerIsBetter": true, "replicates": [76.0, 71.0, 80.0, 71.0, 72.0, 73.0, 70.0, 70.0, 70.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.4}], "name": "kraken", "value": 1543.8000000000002}]} 18:49:57 INFO - Return code: 0 18:49:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:49:57 ERROR - # TBPL SUCCESS # 18:49:57 INFO - Running post-action listener: _resource_record_post_action 18:49:57 INFO - Running post-run listener: _resource_record_post_run 18:49:58 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 535220224; Read time: 0; Write time: 837716 18:49:58 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 243818496; Read time: 0; Write time: 521752 18:49:58 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 287465472; Read time: 0; Write time: 315412 18:49:58 INFO - Running post-run listener: _upload_blobber_files 18:49:58 INFO - Blob upload gear active. 18:49:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:49:58 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 18:49:58 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'] 18:49:58 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 18:49:59 INFO - (blobuploader) - INFO - Open directory for files ... 18:49:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:49:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:49:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:50:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:00 INFO - (blobuploader) - INFO - Done attempting. 18:50:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:50:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:50:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:50:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:50:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:50:00 INFO - (blobuploader) - INFO - Done attempting. 18:50:00 INFO - (blobuploader) - INFO - Iteration through files over. 18:50:00 INFO - Return code: 0 18:50:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:50:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:50:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/092c6329ef152aa9d07132450562d695d39d5b27c6d792d429f32ac9fa7a3e18bff4ec31cc477b5254cbc4ebf27b9a88166774c56d711a58cff905412facaa08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0ae9399ee52645a35d30243d3166734f33c6f18e15795dce38bb2673bb03e9d5c8711105b565f56c3dadde5c81e7b28b447dae49f99612eacaa1ea22d2803d6"} 18:50:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:50:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:50:00 INFO - Contents: 18:50:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/092c6329ef152aa9d07132450562d695d39d5b27c6d792d429f32ac9fa7a3e18bff4ec31cc477b5254cbc4ebf27b9a88166774c56d711a58cff905412facaa08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0ae9399ee52645a35d30243d3166734f33c6f18e15795dce38bb2673bb03e9d5c8711105b565f56c3dadde5c81e7b28b447dae49f99612eacaa1ea22d2803d6"} 18:50:00 INFO - Running post-run listener: copy_logs_to_upload_dir 18:50:00 INFO - Copying logs to upload dir... 18:50:00 INFO - mkdir: /builds/slave/test/build/upload/logs 18:50:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.456082 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-09 18:50:00.751284) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 18:50:00.755540) ========= 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=5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382 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/092c6329ef152aa9d07132450562d695d39d5b27c6d792d429f32ac9fa7a3e18bff4ec31cc477b5254cbc4ebf27b9a88166774c56d711a58cff905412facaa08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0ae9399ee52645a35d30243d3166734f33c6f18e15795dce38bb2673bb03e9d5c8711105b565f56c3dadde5c81e7b28b447dae49f99612eacaa1ea22d2803d6"} build_url:https://queue.taskcluster.net/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011489 build_url: 'https://queue.taskcluster.net/v1/task/MQZ15tJ0Q7qZsLnluTyQYQ/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/092c6329ef152aa9d07132450562d695d39d5b27c6d792d429f32ac9fa7a3e18bff4ec31cc477b5254cbc4ebf27b9a88166774c56d711a58cff905412facaa08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0ae9399ee52645a35d30243d3166734f33c6f18e15795dce38bb2673bb03e9d5c8711105b565f56c3dadde5c81e7b28b447dae49f99612eacaa1ea22d2803d6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 18:50:00.781471) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:50:00.782088) ========= 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=5bd038846534b2fdfa68eeae000001e2-1457576912.772786-797683382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:50:00.870098) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 18:50:00.870484) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 18:50:00.870839) ========= ========= Total master_lag: 0.29 =========