builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1459623747.38 results: success (0) buildid: 20160402103649 builduid: df1629e3da4849c0a01565d242e0f99b revision: 55d557f4d73ee58664bdf2fa85aaab555224722e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:27.384470) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:27.384996) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:27.385321) ========= 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=ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006415 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:27.413650) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:27.413995) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:27.436760) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:27.437153) ========= 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=ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:27.489765) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:27.490073) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:27.490454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-02 12:02:27.490730) ========= 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=ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-02 12:02:28-- 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.8M=0s 2016-04-02 12:02:28 (41.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174997 ========= master_lag: 2.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-02 12:02:29.806612) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:29.806900) ========= 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=ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022305 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:29.884409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:29.884751) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 55d557f4d73ee58664bdf2fa85aaab555224722e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 55d557f4d73ee58664bdf2fa85aaab555224722e --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=ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-02 12:02:30,890 truncating revision to first 12 chars 2016-04-02 12:02:30,890 Setting DEBUG logging. 2016-04-02 12:02:30,890 attempt 1/10 2016-04-02 12:02:30,890 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/55d557f4d73e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-02 12:02:31,173 unpacking tar archive at: mozilla-central-55d557f4d73e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545247 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:30.449574) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:30.449879) ========= echo 55d557f4d73ee58664bdf2fa85aaab555224722e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'55d557f4d73ee58664bdf2fa85aaab555224722e'] 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=ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 55d557f4d73ee58664bdf2fa85aaab555224722e program finished with exit code 0 elapsedTime=0.004688 script_repo_revision: '55d557f4d73ee58664bdf2fa85aaab555224722e' ========= master_lag: 0.08 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:30.535557) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:30.535861) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-02 12:02:30.546785) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-02 12:02:30.547063) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:02:31 INFO - MultiFileLogger online at 20160402 12:02:31 in /builds/slave/test 12:02:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 12:02:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:02:31 INFO - {'append_to_log': False, 12:02:31 INFO - 'base_work_dir': '/builds/slave/test', 12:02:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:02:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:02:31 INFO - 'branch': 'Firefox-Non-PGO', 12:02:31 INFO - 'buildbot_json_path': 'buildprops.json', 12:02:31 INFO - 'config_files': ('talos/linux_config.py',), 12:02:31 INFO - 'default_actions': ('clobber', 12:02:31 INFO - 'read-buildbot-config', 12:02:31 INFO - 'download-and-extract', 12:02:31 INFO - 'populate-webroot', 12:02:31 INFO - 'create-virtualenv', 12:02:31 INFO - 'install', 12:02:31 INFO - 'run-tests'), 12:02:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:02:31 INFO - 'download_minidump_stackwalk': True, 12:02:31 INFO - 'download_symbols': 'ondemand', 12:02:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:02:31 INFO - 'tooltool.py': '/tools/tooltool.py', 12:02:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:02:31 INFO - '/tools/misc-python/virtualenv.py')}, 12:02:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:02:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:02:31 INFO - 'installer_path': 'installer.exe', 12:02:31 INFO - 'log_level': 'info', 12:02:31 INFO - 'log_name': 'talos', 12:02:31 INFO - 'log_to_console': True, 12:02:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:02:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:02:31 INFO - 'opt_config_files': (), 12:02:31 INFO - 'pip_index': False, 12:02:31 INFO - 'sps_profile': False, 12:02:31 INFO - 'sps_profile_interval': 0, 12:02:31 INFO - 'suite': 'dromaeojs', 12:02:31 INFO - 'system_bits': '32', 12:02:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:02:31 INFO - 'title': 'talos-linux64-ix-035', 12:02:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:02:31 INFO - 'use_talos_json': True, 12:02:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:02:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:02:31 INFO - 'work_dir': 'build'} 12:02:31 INFO - ##### 12:02:31 INFO - ##### Running clobber step. 12:02:31 INFO - ##### 12:02:31 INFO - Running pre-action listener: _resource_record_pre_action 12:02:31 INFO - Running main action method: clobber 12:02:31 INFO - rmtree: /builds/slave/test/build 12:02:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:02:32 INFO - Running post-action listener: _resource_record_post_action 12:02:32 INFO - ##### 12:02:32 INFO - ##### Running read-buildbot-config step. 12:02:32 INFO - ##### 12:02:32 INFO - Running pre-action listener: _resource_record_pre_action 12:02:32 INFO - Running main action method: read_buildbot_config 12:02:32 INFO - Using buildbot properties: 12:02:32 INFO - { 12:02:32 INFO - "project": "", 12:02:32 INFO - "product": "firefox", 12:02:32 INFO - "script_repo_revision": "production", 12:02:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:02:32 INFO - "repository": "", 12:02:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 12:02:32 INFO - "buildid": "20160402103649", 12:02:32 INFO - "pgo_build": "False", 12:02:32 INFO - "basedir": "/builds/slave/test", 12:02:32 INFO - "buildnumber": 47, 12:02:32 INFO - "slavename": "talos-linux64-ix-035", 12:02:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:02:32 INFO - "platform": "ubuntu64_hw", 12:02:32 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 12:02:32 INFO - "branch": "mozilla-central", 12:02:32 INFO - "repo_path": "mozilla-central", 12:02:32 INFO - "revision": "55d557f4d73ee58664bdf2fa85aaab555224722e", 12:02:32 INFO - "stage_platform": "linux64", 12:02:32 INFO - "builduid": "df1629e3da4849c0a01565d242e0f99b", 12:02:32 INFO - "slavebuilddir": "test" 12:02:32 INFO - } 12:02:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:02:32 INFO - Running post-action listener: _resource_record_post_action 12:02:32 INFO - ##### 12:02:32 INFO - ##### Running download-and-extract step. 12:02:32 INFO - ##### 12:02:32 INFO - Running pre-action listener: _resource_record_pre_action 12:02:32 INFO - Running main action method: download_and_extract 12:02:32 INFO - mkdir: /builds/slave/test/build/tests 12:02: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')]} 12:02:32 INFO - https://queue.taskcluster.net/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:02:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:02:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:02:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/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 12:02:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/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 12:02:44 INFO - Downloaded 1361 bytes. 12:02:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:02:44 INFO - Using the following test package requirements: 12:02:44 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:02:44 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:02:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:02:44 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:02:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:02:44 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:02:44 INFO - u'jsshell-linux-x86_64.zip'], 12:02:44 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:02:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:02:44 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:02:44 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:02:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:02:44 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:02:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:02:44 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:02:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:02:44 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:02:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:02:44 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:02:44 INFO - https://queue.taskcluster.net/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:02:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:02:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:02:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/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 12:02:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/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 12:02:56 INFO - Downloaded 22125172 bytes. 12:02:56 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'] 12:02:56 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 12:02:57 INFO - Return code: 0 12:02:57 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 12:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:02:57 INFO - https://queue.taskcluster.net/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:02:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:02:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:02:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/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 12:02:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/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 12:02:59 INFO - Downloaded 22125172 bytes. 12:02:59 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'] 12:02:59 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 12:03:00 INFO - Return code: 0 12:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:00 INFO - https://queue.taskcluster.net/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:03:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:03:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:03:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/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 12:03:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/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 12:03:01 INFO - Downloaded 10847584 bytes. 12:03:01 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'] 12:03:01 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 12:03:01 INFO - Return code: 0 12:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:01 INFO - https://queue.taskcluster.net/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:03:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:03:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:03:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/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 12:03:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d5a6-XkRRpmNI2lkcD077A/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 12:03:04 INFO - Downloaded 54100684 bytes. 12:03:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:03:04 INFO - mkdir: /builds/slave/test/properties 12:03:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:03:04 INFO - Writing to file /builds/slave/test/properties/build_url 12:03:04 INFO - Contents: 12:03:04 INFO - build_url:https://queue.taskcluster.net/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:03:05 INFO - Running post-action listener: _resource_record_post_action 12:03:05 INFO - Running post-action listener: set_extra_try_arguments 12:03:05 INFO - ##### 12:03:05 INFO - ##### Running populate-webroot step. 12:03:05 INFO - ##### 12:03:05 INFO - Running pre-action listener: _resource_record_pre_action 12:03:05 INFO - Running main action method: populate_webroot 12:03:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:03:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:03:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:03:05 INFO - '--tppagecycles', 12:03:05 INFO - '7'], 12:03:05 INFO - 'tests': ['tsvgm']}}, 12:03:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:03:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:03:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:03:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:03:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:03:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:03:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:03:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:05 INFO - 'talos_options': ['--e10s'], 12:03:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:03:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:05 INFO - 'tests': ['damp', 'tps']}, 12:03:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:05 INFO - 'talos_options': ['--e10s'], 12:03:05 INFO - 'tests': ['damp', 'tps']}, 12:03:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:03:05 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 12:03:05 INFO - 'tests': ['dromaeo_dom']}, 12:03:05 INFO - 'other': {'tests': ['a11yr', 12:03:05 INFO - 'ts_paint', 12:03:05 INFO - 'tpaint', 12:03:05 INFO - 'sessionrestore', 12:03:05 INFO - 'sessionrestore_no_auto_restore', 12:03:05 INFO - 'tabpaint']}, 12:03:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:03:05 INFO - 'tests': ['a11yr', 12:03:05 INFO - 'ts_paint', 12:03:05 INFO - 'tpaint', 12:03:05 INFO - 'sessionrestore', 12:03:05 INFO - 'sessionrestore_no_auto_restore', 12:03:05 INFO - 'tabpaint']}, 12:03:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:03:05 INFO - 'tests': ['a11yr', 12:03:05 INFO - 'ts_paint', 12:03:05 INFO - 'tpaint', 12:03:05 INFO - 'sessionrestore', 12:03:05 INFO - 'sessionrestore_no_auto_restore', 12:03:05 INFO - 'tabpaint']}, 12:03:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:03:05 INFO - 'tests': ['a11yr', 12:03:05 INFO - 'ts_paint', 12:03:05 INFO - 'tpaint', 12:03:05 INFO - 'sessionrestore', 12:03:05 INFO - 'sessionrestore_no_auto_restore', 12:03:05 INFO - 'tabpaint']}, 12:03:05 INFO - 'other_l64': {'tests': ['a11yr', 12:03:05 INFO - 'ts_paint', 12:03:05 INFO - 'tpaint', 12:03:05 INFO - 'sessionrestore', 12:03:05 INFO - 'sessionrestore_no_auto_restore', 12:03:05 INFO - 'tabpaint']}, 12:03:05 INFO - 'other_nol64': {'tests': ['a11yr', 12:03:05 INFO - 'ts_paint', 12:03:05 INFO - 'tpaint', 12:03:05 INFO - 'sessionrestore', 12:03:05 INFO - 'sessionrestore_no_auto_restore', 12:03:05 INFO - 'tabpaint']}, 12:03:05 INFO - 'svgr': {'tests': ['tsvgx', 12:03:05 INFO - 'tsvgr_opacity', 12:03:05 INFO - 'tart', 12:03:05 INFO - 'tscrollx', 12:03:05 INFO - 'cart']}, 12:03:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:03:05 INFO - 'tests': ['tsvgx', 12:03:05 INFO - 'tsvgr_opacity', 12:03:05 INFO - 'tart', 12:03:05 INFO - 'tscrollx', 12:03:05 INFO - 'cart']}, 12:03:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:05 INFO - 'tests': ['tp5o']}, 12:03:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:05 INFO - 'talos_options': ['--e10s'], 12:03:05 INFO - 'tests': ['tp5o']}, 12:03:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:05 INFO - 'talos_options': ['--xperf_path', 12:03:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:03:05 INFO - 'tests': ['tp5n']}, 12:03:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:03:05 INFO - 'talos_options': ['--e10s', 12:03:05 INFO - '--xperf_path', 12:03:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:03:05 INFO - 'tests': ['tp5n']}}, 12:03:05 INFO - 'talos.zip': {'path': '', 12:03:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:03:05 INFO - Running post-action listener: _resource_record_post_action 12:03:05 INFO - ##### 12:03:05 INFO - ##### Running create-virtualenv step. 12:03:05 INFO - ##### 12:03:05 INFO - Running pre-action listener: _resource_record_pre_action 12:03:05 INFO - Running main action method: create_virtualenv 12:03:05 INFO - Creating virtualenv /builds/slave/test/build/venv 12:03:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:03:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:03:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:03:05 INFO - Using real prefix '/usr' 12:03:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:03:06 INFO - Installing distribute.............................................................................................................................................................................................done. 12:03:08 INFO - Installing pip.................done. 12:03:08 INFO - Return code: 0 12:03:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:08 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 0x7f8bb3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b410>, '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 0x225c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:03:08 INFO - Using env: {'DISPLAY': ':0', 12:03:08 INFO - 'HOME': '/home/cltbld', 12:03:08 INFO - 'LANG': 'en_US.UTF-8', 12:03:08 INFO - 'LANGUAGE': 'en_US:en', 12:03:08 INFO - 'LOGNAME': 'cltbld', 12:03:08 INFO - 'MAIL': '/var/mail/cltbld', 12:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:08 INFO - 'MOZ_NO_REMOTE': '1', 12:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:08 INFO - 'NO_EM_RESTART': '1', 12:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:08 INFO - 'PWD': '/builds/slave/test', 12:03:08 INFO - 'SHELL': '/bin/bash', 12:03:08 INFO - 'SHLVL': '1', 12:03:08 INFO - 'TERM': 'linux', 12:03:08 INFO - 'TMOUT': '86400', 12:03:08 INFO - 'USER': 'cltbld', 12:03:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 12:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:08 INFO - '_': '/tools/buildbot/bin/python'} 12:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:03:08 INFO - Cleaning up... 12:03:08 INFO - Return code: 0 12:03:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:08 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 0x7f8bb3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b410>, '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 0x225c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:03:08 INFO - Using env: {'DISPLAY': ':0', 12:03:08 INFO - 'HOME': '/home/cltbld', 12:03:08 INFO - 'LANG': 'en_US.UTF-8', 12:03:08 INFO - 'LANGUAGE': 'en_US:en', 12:03:08 INFO - 'LOGNAME': 'cltbld', 12:03:08 INFO - 'MAIL': '/var/mail/cltbld', 12:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:08 INFO - 'MOZ_NO_REMOTE': '1', 12:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:08 INFO - 'NO_EM_RESTART': '1', 12:03:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:08 INFO - 'PWD': '/builds/slave/test', 12:03:08 INFO - 'SHELL': '/bin/bash', 12:03:08 INFO - 'SHLVL': '1', 12:03:08 INFO - 'TERM': 'linux', 12:03:08 INFO - 'TMOUT': '86400', 12:03:08 INFO - 'USER': 'cltbld', 12:03:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 12:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:08 INFO - '_': '/tools/buildbot/bin/python'} 12:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:08 INFO - Downloading/unpacking psutil>=0.7.1 12:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:03:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:03:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:03:11 INFO - Installing collected packages: psutil 12:03:11 INFO - Running setup.py install for psutil 12:03:11 INFO - building 'psutil._psutil_linux' extension 12:03:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:03:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:03:11 INFO - building 'psutil._psutil_posix' extension 12:03:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:03:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:03:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:03:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:03:12 INFO - Successfully installed psutil 12:03:12 INFO - Cleaning up... 12:03:12 INFO - Return code: 0 12:03:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:12 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 0x7f8bb3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b410>, '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 0x225c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:03:12 INFO - Using env: {'DISPLAY': ':0', 12:03:12 INFO - 'HOME': '/home/cltbld', 12:03:12 INFO - 'LANG': 'en_US.UTF-8', 12:03:12 INFO - 'LANGUAGE': 'en_US:en', 12:03:12 INFO - 'LOGNAME': 'cltbld', 12:03:12 INFO - 'MAIL': '/var/mail/cltbld', 12:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:12 INFO - 'MOZ_NO_REMOTE': '1', 12:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:12 INFO - 'NO_EM_RESTART': '1', 12:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:12 INFO - 'PWD': '/builds/slave/test', 12:03:12 INFO - 'SHELL': '/bin/bash', 12:03:12 INFO - 'SHLVL': '1', 12:03:12 INFO - 'TERM': 'linux', 12:03:12 INFO - 'TMOUT': '86400', 12:03:12 INFO - 'USER': 'cltbld', 12:03:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 12:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:12 INFO - '_': '/tools/buildbot/bin/python'} 12:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:03:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:03:14 INFO - Installing collected packages: mozsystemmonitor 12:03:14 INFO - Running setup.py install for mozsystemmonitor 12:03:14 INFO - Successfully installed mozsystemmonitor 12:03:14 INFO - Cleaning up... 12:03:14 INFO - Return code: 0 12:03:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:14 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 0x7f8bb3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b410>, '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 0x225c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:03:14 INFO - Using env: {'DISPLAY': ':0', 12:03:14 INFO - 'HOME': '/home/cltbld', 12:03:14 INFO - 'LANG': 'en_US.UTF-8', 12:03:14 INFO - 'LANGUAGE': 'en_US:en', 12:03:14 INFO - 'LOGNAME': 'cltbld', 12:03:14 INFO - 'MAIL': '/var/mail/cltbld', 12:03:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:14 INFO - 'MOZ_NO_REMOTE': '1', 12:03:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:14 INFO - 'NO_EM_RESTART': '1', 12:03:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:14 INFO - 'PWD': '/builds/slave/test', 12:03:14 INFO - 'SHELL': '/bin/bash', 12:03:14 INFO - 'SHLVL': '1', 12:03:14 INFO - 'TERM': 'linux', 12:03:14 INFO - 'TMOUT': '86400', 12:03:14 INFO - 'USER': 'cltbld', 12:03:14 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 12:03:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:14 INFO - '_': '/tools/buildbot/bin/python'} 12:03:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:14 INFO - Downloading/unpacking blobuploader==1.2.4 12:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:16 INFO - Downloading blobuploader-1.2.4.tar.gz 12:03:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:03:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:03:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:17 INFO - Downloading docopt-0.6.1.tar.gz 12:03:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:03:17 INFO - Installing collected packages: blobuploader, requests, docopt 12:03:17 INFO - Running setup.py install for blobuploader 12:03:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:03:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:03:17 INFO - Running setup.py install for requests 12:03:17 INFO - Running setup.py install for docopt 12:03:17 INFO - Successfully installed blobuploader requests docopt 12:03:17 INFO - Cleaning up... 12:03:17 INFO - Return code: 0 12:03:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:17 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 0x7f8bb3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b410>, '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 0x225c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:03:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:03:17 INFO - Using env: {'DISPLAY': ':0', 12:03:17 INFO - 'HOME': '/home/cltbld', 12:03:17 INFO - 'LANG': 'en_US.UTF-8', 12:03:17 INFO - 'LANGUAGE': 'en_US:en', 12:03:17 INFO - 'LOGNAME': 'cltbld', 12:03:17 INFO - 'MAIL': '/var/mail/cltbld', 12:03:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:17 INFO - 'MOZ_NO_REMOTE': '1', 12:03:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:17 INFO - 'NO_EM_RESTART': '1', 12:03:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:17 INFO - 'PWD': '/builds/slave/test', 12:03:17 INFO - 'SHELL': '/bin/bash', 12:03:17 INFO - 'SHLVL': '1', 12:03:17 INFO - 'TERM': 'linux', 12:03:17 INFO - 'TMOUT': '86400', 12:03:17 INFO - 'USER': 'cltbld', 12:03:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 12:03:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:17 INFO - '_': '/tools/buildbot/bin/python'} 12:03:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:03:18 INFO - Running setup.py (path:/tmp/pip-1itwGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:03:18 INFO - Running setup.py (path:/tmp/pip-IAWONb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:03:18 INFO - Running setup.py (path:/tmp/pip-GsFvIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:03:18 INFO - Running setup.py (path:/tmp/pip-SkXGmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:03:18 INFO - Running setup.py (path:/tmp/pip-a2T1OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:03:18 INFO - Running setup.py (path:/tmp/pip-bI85p3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:03:18 INFO - Running setup.py (path:/tmp/pip-WZOEXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:03:18 INFO - Running setup.py (path:/tmp/pip-zKFKpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:03:18 INFO - Running setup.py (path:/tmp/pip-Lh8CZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:03:18 INFO - Running setup.py (path:/tmp/pip-bCzEji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:03:18 INFO - Running setup.py (path:/tmp/pip-tEaRKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:03:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:03:18 INFO - Running setup.py (path:/tmp/pip-H6AX9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:03:19 INFO - Running setup.py (path:/tmp/pip-ptkAqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:03:19 INFO - Running setup.py (path:/tmp/pip-0mH2jI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:19 INFO - Running setup.py (path:/tmp/pip-2Jxp9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:03:19 INFO - Running setup.py (path:/tmp/pip-ZouJHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:03:19 INFO - Running setup.py (path:/tmp/pip-Lu7tei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:03:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:03:19 INFO - Running setup.py install for manifestparser 12:03:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:03:19 INFO - Running setup.py install for mozcrash 12:03:19 INFO - Running setup.py install for mozdebug 12:03:19 INFO - Running setup.py install for mozdevice 12:03:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:03:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:03:19 INFO - Running setup.py install for mozfile 12:03:19 INFO - Running setup.py install for mozhttpd 12:03:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:03:20 INFO - Running setup.py install for mozinfo 12:03:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:03:20 INFO - Running setup.py install for mozInstall 12:03:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:03:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:03:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:03:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:03:20 INFO - Running setup.py install for mozleak 12:03:20 INFO - Running setup.py install for mozlog 12:03:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:03:20 INFO - Running setup.py install for moznetwork 12:03:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:03:20 INFO - Running setup.py install for mozprocess 12:03:20 INFO - Running setup.py install for mozprofile 12:03:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:03:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:03:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:03:20 INFO - Running setup.py install for mozrunner 12:03:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:03:20 INFO - Running setup.py install for mozscreenshot 12:03:20 INFO - Running setup.py install for moztest 12:03:21 INFO - Running setup.py install for mozversion 12:03:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:03:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:03:21 INFO - Cleaning up... 12:03:21 INFO - Return code: 0 12:03:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:21 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 0x7f8bb3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b410>, '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 0x225c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:03:21 INFO - Using env: {'DISPLAY': ':0', 12:03:21 INFO - 'HOME': '/home/cltbld', 12:03:21 INFO - 'LANG': 'en_US.UTF-8', 12:03:21 INFO - 'LANGUAGE': 'en_US:en', 12:03:21 INFO - 'LOGNAME': 'cltbld', 12:03:21 INFO - 'MAIL': '/var/mail/cltbld', 12:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:21 INFO - 'MOZ_NO_REMOTE': '1', 12:03:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:21 INFO - 'NO_EM_RESTART': '1', 12:03:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:21 INFO - 'PWD': '/builds/slave/test', 12:03:21 INFO - 'SHELL': '/bin/bash', 12:03:21 INFO - 'SHLVL': '1', 12:03:21 INFO - 'TERM': 'linux', 12:03:21 INFO - 'TMOUT': '86400', 12:03:21 INFO - 'USER': 'cltbld', 12:03:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 12:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:21 INFO - '_': '/tools/buildbot/bin/python'} 12:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:03:21 INFO - Running setup.py (path:/tmp/pip-MRJ0y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:03:21 INFO - Running setup.py (path:/tmp/pip-GYfhL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:03:21 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)) 12:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:03:21 INFO - Running setup.py (path:/tmp/pip-OJ0unJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:03:21 INFO - Running setup.py (path:/tmp/pip-9dxC7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:03:21 INFO - Running setup.py (path:/tmp/pip-F2ITPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:03:21 INFO - Running setup.py (path:/tmp/pip-VxBuZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:03:21 INFO - Running setup.py (path:/tmp/pip-IlG4FJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:03:21 INFO - Running setup.py (path:/tmp/pip-n9qtZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:03:21 INFO - Running setup.py (path:/tmp/pip-WS4gNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:03:22 INFO - Running setup.py (path:/tmp/pip-x0azlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:03:22 INFO - Running setup.py (path:/tmp/pip-eL6aWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:03:22 INFO - Running setup.py (path:/tmp/pip-KzCdTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:03:22 INFO - Running setup.py (path:/tmp/pip-5XcY57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:03:22 INFO - Running setup.py (path:/tmp/pip-jj6epQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:22 INFO - Running setup.py (path:/tmp/pip-E2iDtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:03:22 INFO - Running setup.py (path:/tmp/pip-1_MBaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:03:22 INFO - Running setup.py (path:/tmp/pip-NsygG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:03:22 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)) 12:03:22 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)) 12:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:03:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:24 INFO - Downloading blessings-1.6.tar.gz 12:03:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:03:24 INFO - Installing collected packages: blessings 12:03:24 INFO - Running setup.py install for blessings 12:03:24 INFO - Successfully installed blessings 12:03:24 INFO - Cleaning up... 12:03:24 INFO - Return code: 0 12:03:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:03:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:03:24 INFO - Reading from file tmpfile_stdout 12:03:24 INFO - Current package versions: 12:03:24 INFO - argparse == 1.2.1 12:03:24 INFO - blessings == 1.6 12:03:24 INFO - blobuploader == 1.2.4 12:03:24 INFO - docopt == 0.6.1 12:03:24 INFO - manifestparser == 1.1 12:03:24 INFO - mozInstall == 1.12 12:03:24 INFO - mozcrash == 0.17 12:03:24 INFO - mozdebug == 0.1 12:03:24 INFO - mozdevice == 0.48 12:03:24 INFO - mozfile == 1.2 12:03:24 INFO - mozhttpd == 0.7 12:03:24 INFO - mozinfo == 0.9 12:03:24 INFO - mozleak == 0.1 12:03:24 INFO - mozlog == 3.1 12:03:24 INFO - moznetwork == 0.27 12:03:24 INFO - mozprocess == 0.22 12:03:24 INFO - mozprofile == 0.28 12:03:24 INFO - mozrunner == 6.11 12:03:24 INFO - mozscreenshot == 0.1 12:03:24 INFO - mozsystemmonitor == 0.0 12:03:24 INFO - moztest == 0.7 12:03:24 INFO - mozversion == 1.4 12:03:24 INFO - psutil == 3.1.1 12:03:24 INFO - requests == 1.2.3 12:03:24 INFO - wsgiref == 0.1.2 12:03:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:24 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 0x7f8bb3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b410>, '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 0x225c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:03:24 INFO - Using env: {'DISPLAY': ':0', 12:03:24 INFO - 'HOME': '/home/cltbld', 12:03:24 INFO - 'LANG': 'en_US.UTF-8', 12:03:24 INFO - 'LANGUAGE': 'en_US:en', 12:03:24 INFO - 'LOGNAME': 'cltbld', 12:03:24 INFO - 'MAIL': '/var/mail/cltbld', 12:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:24 INFO - 'MOZ_NO_REMOTE': '1', 12:03:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:24 INFO - 'NO_EM_RESTART': '1', 12:03:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:24 INFO - 'PWD': '/builds/slave/test', 12:03:24 INFO - 'SHELL': '/bin/bash', 12:03:24 INFO - 'SHLVL': '1', 12:03:24 INFO - 'TERM': 'linux', 12:03:24 INFO - 'TMOUT': '86400', 12:03:24 INFO - 'USER': 'cltbld', 12:03:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 12:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:24 INFO - '_': '/tools/buildbot/bin/python'} 12:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:03:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:03:25 INFO - Cleaning up... 12:03:25 INFO - Return code: 0 12:03:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:03: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')]} 12:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03: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')]} 12:03:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:25 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 0x7f8bb3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b410>, '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 0x225c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:03:25 INFO - Using env: {'DISPLAY': ':0', 12:03:25 INFO - 'HOME': '/home/cltbld', 12:03:25 INFO - 'LANG': 'en_US.UTF-8', 12:03:25 INFO - 'LANGUAGE': 'en_US:en', 12:03:25 INFO - 'LOGNAME': 'cltbld', 12:03:25 INFO - 'MAIL': '/var/mail/cltbld', 12:03:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:25 INFO - 'MOZ_NO_REMOTE': '1', 12:03:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:25 INFO - 'NO_EM_RESTART': '1', 12:03:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:25 INFO - 'PWD': '/builds/slave/test', 12:03:25 INFO - 'SHELL': '/bin/bash', 12:03:25 INFO - 'SHLVL': '1', 12:03:25 INFO - 'TERM': 'linux', 12:03:25 INFO - 'TMOUT': '86400', 12:03:25 INFO - 'USER': 'cltbld', 12:03:25 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 12:03:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:25 INFO - '_': '/tools/buildbot/bin/python'} 12:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:25 INFO - Downloading/unpacking jsonschema 12:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:03:27 INFO - Downloading/unpacking functools32 (from jsonschema) 12:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:27 INFO - Downloading functools32-3.2.3-2.tar.gz 12:03:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:03:27 INFO - warning: no files found matching '*.txt' 12:03:27 INFO - no previously-included directories found matching 'build' 12:03:27 INFO - no previously-included directories found matching 'dist' 12:03:27 INFO - no previously-included directories found matching '.git*' 12:03:27 INFO - Installing collected packages: jsonschema, functools32 12:03:27 INFO - Running setup.py install for functools32 12:03:27 INFO - warning: no files found matching '*.txt' 12:03:27 INFO - no previously-included directories found matching 'build' 12:03:27 INFO - no previously-included directories found matching 'dist' 12:03:27 INFO - no previously-included directories found matching '.git*' 12:03:27 INFO - Successfully installed jsonschema functools32 12:03:27 INFO - Cleaning up... 12:03:28 INFO - Return code: 0 12:03:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:03: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')]} 12:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03: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')]} 12:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:28 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 0x7f8bb3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225b410>, '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 0x225c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:03:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:03:28 INFO - Using env: {'DISPLAY': ':0', 12:03:28 INFO - 'HOME': '/home/cltbld', 12:03:28 INFO - 'LANG': 'en_US.UTF-8', 12:03:28 INFO - 'LANGUAGE': 'en_US:en', 12:03:28 INFO - 'LOGNAME': 'cltbld', 12:03:28 INFO - 'MAIL': '/var/mail/cltbld', 12:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:28 INFO - 'MOZ_NO_REMOTE': '1', 12:03:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:28 INFO - 'NO_EM_RESTART': '1', 12:03:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:28 INFO - 'PWD': '/builds/slave/test', 12:03:28 INFO - 'SHELL': '/bin/bash', 12:03:28 INFO - 'SHLVL': '1', 12:03:28 INFO - 'TERM': 'linux', 12:03:28 INFO - 'TMOUT': '86400', 12:03:28 INFO - 'USER': 'cltbld', 12:03:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 12:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:28 INFO - '_': '/tools/buildbot/bin/python'} 12:03:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:28 INFO - Downloading/unpacking flake8 12:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:03:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:03:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:03:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:03:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:03:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:03:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:03:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:03:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:03:31 INFO - no previously-included directories found matching 'docs/_build' 12:03:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:03:31 INFO - Running setup.py install for pep8 12:03:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:03:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:03:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:03:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:03:31 INFO - no previously-included directories found matching 'docs/_build' 12:03:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:03:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:03:31 INFO - Cleaning up... 12:03:31 INFO - Return code: 0 12:03:31 INFO - Running post-action listener: _resource_record_post_action 12:03:31 INFO - Running post-action listener: _start_resource_monitoring 12:03:31 INFO - Starting resource monitoring. 12:03:31 INFO - ##### 12:03:31 INFO - ##### Running install step. 12:03:31 INFO - ##### 12:03:31 INFO - Running pre-action listener: _resource_record_pre_action 12:03:31 INFO - Running main action method: install 12:03:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:03:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:03:31 INFO - Reading from file tmpfile_stdout 12:03:31 INFO - Detecting whether we're running mozinstall >=1.0... 12:03:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:03:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:03:31 INFO - Reading from file tmpfile_stdout 12:03:31 INFO - Output received: 12:03:31 INFO - Usage: mozinstall [options] installer 12:03:31 INFO - Options: 12:03:31 INFO - -h, --help show this help message and exit 12:03:31 INFO - -d DEST, --destination=DEST 12:03:31 INFO - Directory to install application into. [default: 12:03:31 INFO - "/builds/slave/test"] 12:03:31 INFO - --app=APP Application being installed. [default: firefox] 12:03:31 INFO - mkdir: /builds/slave/test/build/application 12:03:31 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'] 12:03:31 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 12:03:47 INFO - Reading from file tmpfile_stdout 12:03:47 INFO - Output received: 12:03:47 INFO - /builds/slave/test/build/application/firefox/firefox 12:03:47 INFO - Running post-action listener: _resource_record_post_action 12:03:47 INFO - ##### 12:03:47 INFO - ##### Running run-tests step. 12:03:47 INFO - ##### 12:03:47 INFO - Running pre-action listener: _resource_record_pre_action 12:03:47 INFO - Running main action method: run_tests 12:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:03:47 INFO - Python 2.7.3 12:03:47 INFO - Return code: 0 12:03:47 INFO - grabbing minidump binary from tooltool 12:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:03:47 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 0x225b410>, '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 0x225c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x225c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:03:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:03:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:03:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:03:47 INFO - Return code: 0 12:03:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:03:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:03:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:03:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:03:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:03:48 INFO - Return code: 0 12:03:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:03:48 INFO - Using env: {'DISPLAY': ':0', 12:03:48 INFO - 'HOME': '/home/cltbld', 12:03:48 INFO - 'LANG': 'en_US.UTF-8', 12:03:48 INFO - 'LANGUAGE': 'en_US:en', 12:03:48 INFO - 'LOGNAME': 'cltbld', 12:03:48 INFO - 'MAIL': '/var/mail/cltbld', 12:03:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:03:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:48 INFO - 'MOZ_NO_REMOTE': '1', 12:03:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:03:48 INFO - 'NO_EM_RESTART': '1', 12:03:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:48 INFO - 'PWD': '/builds/slave/test', 12:03:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:03:48 INFO - 'SHELL': '/bin/bash', 12:03:48 INFO - 'SHLVL': '1', 12:03:48 INFO - 'TERM': 'linux', 12:03:48 INFO - 'TMOUT': '86400', 12:03:48 INFO - 'USER': 'cltbld', 12:03:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887', 12:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:48 INFO - '_': '/tools/buildbot/bin/python'} 12:03:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:03:48 INFO - mozversion application_buildid: 20160402103649 12:03:48 INFO - mozversion application_changeset: 55d557f4d73ee58664bdf2fa85aaab555224722e 12:03:48 INFO - mozversion application_display_name: Nightly 12:03:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:03:48 INFO - mozversion application_name: Firefox 12:03:48 INFO - mozversion application_remotingname: firefox 12:03:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:03:48 INFO - mozversion application_vendor: Mozilla 12:03:48 INFO - mozversion application_version: 48.0a1 12:03:48 INFO - mozversion platform_buildid: 20160402103649 12:03:48 INFO - mozversion platform_changeset: 55d557f4d73ee58664bdf2fa85aaab555224722e 12:03:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:03:48 INFO - mozversion platform_version: 48.0a1 12:03:48 INFO - using testdate: 1459623828 12:03:48 INFO - actual date: 1459623828 12:03:48 INFO - starting webserver on 'localhost:57107' 12:03:48 INFO - SUITE-START | Running 2 tests 12:03:48 INFO - TEST-START | dromaeo_css 12:03:48 INFO - operating with platform_type : linux_ 12:03:48 INFO - Initialising browser for dromaeo_css test... 12:03:48 INFO - TEST-INFO | started process 5243 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppOUnsG/profile http://localhost:57107/getInfo.html) 12:03:53 INFO - PROCESS | 5243 | __metrics Screen width/height:1600/1200 12:03:53 INFO - PROCESS | 5243 | colorDepth:24 12:03:53 INFO - PROCESS | 5243 | Browser inner width/height: 1024/697 12:03:53 INFO - PROCESS | 5243 | __metrics 12:03:53 ERROR - PROCESS | 5243 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:03:54 INFO - TEST-INFO | 5243: exit 0 12:03:54 INFO - Browser initialized. 12:03:54 INFO - Running cycle 1/1 for dromaeo_css test... 12:03:54 INFO - TEST-INFO | started process 5324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppOUnsG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:04:06 INFO - PROCESS | 5324 | RSS: Main: 155193344 12:04:06 INFO - PROCESS | 5324 | 12:04:57 INFO - PROCESS | 5324 | 1459623897494 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:07:09 INFO - PROCESS | 5324 | Cycle 1(1): loaded http://localhost:57107/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57107/tests/dromaeo/cssquery-ext.html) 12:07:10 INFO - PROCESS | 5324 | RSS: Main: 236867584 12:07:10 INFO - PROCESS | 5324 | 12:10:12 INFO - PROCESS | 5324 | Cycle 1(1): loaded http://localhost:57107/tests/dromaeo/cssquery-ext.html (next: http://localhost:57107/tests/dromaeo/cssquery-jquery.html) 12:10:13 INFO - PROCESS | 5324 | RSS: Main: 234622976 12:10:13 INFO - PROCESS | 5324 | 12:13:15 INFO - PROCESS | 5324 | Cycle 1(1): loaded http://localhost:57107/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57107/tests/dromaeo/cssquery-mootools.html) 12:13:15 INFO - PROCESS | 5324 | RSS: Main: 236044288 12:13:15 INFO - PROCESS | 5324 | 12:16:17 INFO - PROCESS | 5324 | Cycle 1(1): loaded http://localhost:57107/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57107/tests/dromaeo/cssquery-prototype.html) 12:16:18 INFO - PROCESS | 5324 | RSS: Main: 205152256 12:16:18 INFO - PROCESS | 5324 | 12:19:21 INFO - PROCESS | 5324 | Cycle 1(1): loaded http://localhost:57107/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57107/tests/dromaeo/cssquery-yui.html) 12:19:21 INFO - PROCESS | 5324 | RSS: Main: 204165120 12:19:21 INFO - PROCESS | 5324 | 12:22:24 INFO - PROCESS | 5324 | Cycle 1(1): loaded http://localhost:57107/tests/dromaeo/cssquery-yui.html (next: http://localhost:57107/tests/dromaeo/cssquery-dojo.html) 12:22:24 INFO - PROCESS | 5324 | RSS: Main: 269508608 12:22:24 INFO - PROCESS | 5324 | 12:22:24 INFO - PROCESS | 5324 | __start_tp_report 12:22:24 INFO - PROCESS | 5324 | _x_x_mozilla_page_load 12:22:24 INFO - PROCESS | 5324 | _x_x_mozilla_page_load_details 12:22:24 INFO - PROCESS | 5324 | |i|pagename|runs| 12:22:24 INFO - PROCESS | 5324 | |0;dojo.html;2633.683957925049;2666.0935282004116;2688.8386696798193;2704.999150314385;2722.1833449965006;4650.23271160259;4687.414073240845;4702.600278976287;4744.69159504632;4772.164871147548;4728.503507131744;4728.929066064012;4795.976020119894;4796.920692844108;4801.159797035522;4254.276772948606;4275.828966841323;4283.828646854122;4335.284678028122;4472.7539985300955;4440.267355886275;4493.73037617744;4530.184566777995;4530.97734511327;4539.9773001134945;4285.657147428198;4359.564043595647;4373.737575745434;4428.136513379892;4440.467143942731;4302.763348015857;4313.762743049131;4319.82720691172;4322.502912165079;4324.524302326741;4285.314349704033;4288.056627541967;4288.50682171548;4291.678124140702;4294.484661840599;4562.4753153387455;4613.331066995301;4615.561521655437;4657.604103651193;4669.859904202879;5065.189569668835;5088.92366614501;5095.8980820383385;5116.565091967187;5132.28148059272;5004.5495905368325;5004.9749751251375;5108.233764935252;5115.616328775357;5127.9230811537855;4799.880002999953;4803.447603525639;4806.927896081562;4824.951750482521;4855.150348688965;5211.478852114834;5253.054450198924;5267.578593712494;5281.577473802164;5329.25390445338;4861.9027619447415;4975.228839529878;5061.2661164131;5065.848024559269;5067.8986420271385;5068.847934561895;5087.87280317995;5089.9745501272255;5092.439831618519;5129.8717532061255;5037.79848806051;5038.773255203525;5039.546440820343;5042.268871013683;5077.949220507748;4850.95149048512;4906.730129842822;4942.159832828428;4957.801687932514;5033.144365457881;4370.825166993284;4373.890652733643;4386.035072284092;4388.626966707866;4437.955620443819;3809.675461032443;3851.6533511983494;3869.903252418656;3876.341022026262;3880.941785873214;4260.573942605776;4349.282368409177;4349.978250108792;4379.167958087953;4431.313146462304;5018.473060328686;5044.066847633199;5056;5058.064258112261;5080.415752188472;4316.028893499;4319.654427645781;4333.674974376934;4364.08354245612;4370.2570563004365;4446.088551846864;4556.726596404226;4577.038821847449;4656.301554766812;4666.440027196758;4751.216049351888;4762.928556071731;4763.285507173951;4797.976010119927;4808.807647694053;5052.469490703424;5059.797608095635;5061.721605311596;5080.46655101209;5085.288059671575;4719.126961512131;4780.737059461763;4804.135255654016;4880.853574392774;4887.193613053949;4991.6006719463085;4999.225120106389;5001.899962000813;5009.649324547247;5071.974640126923;5100.107481190851;5118.641695081308;5120.103981803244;5120.667156634956;5120.871978200575;4842.7336496493035;4872.317875497362;4909.0672772173175;4956.083124621812;4973.129702302155;4897.755112244445;4923;4925.433575138905;4928.753562321941;4983.9501604984935;4696.812127514998;4841.540053694894;4866.95133048665;4867.300455535666;4913;4958.057968985881;4967.552920237196;4971.453140154508;5040.697558146523;5049.368828896388;4843.660943734046;4861.246506791453;4864.978354545444;4867.95132048675;4911.582515486224 12:22:24 INFO - PROCESS | 5324 | |1;ext.html;511.08770844043386;541.6506353402053;545.9754311056001;571.5313442976761;583.9124131380293;35154.296914061706;35953.82023089884;36051;36064.45903311452;36119.277614447696;37904.24191516168;38387.00968874042;38423.231535369276;38468.23063538728;38523.614763852354;7691.961540192306;7894.368450523973;7900.525968441883;7910.4462687611895;7922.445428819985;7894.684212631488;8024.317932975704;8043.798905027392;8044.597770111501;8066.274035336818;8041.798955026142;8103.837923241532;8112.513249205037;8113.107558168596;8115.229053239933;7971.641276142587;8048.839023219562;8055.516668999879;8056.274935255826;8057.95971020147;7969.641366138538;8070.71752488666;8081.6363263653275;8087.514749115072;8103.797405064862;38852.222955541016;39153.06352023609;39210.41184382237;39225.803870980744;39255.21489570192;2855.5859400387035;2938.559216117578;3143.402753476832;3207.903762887117;3554.662307080823;29332.853335733398;29771.553426698618;29915.40169196604;30251.546226806397;30639.2340191497;3425;3439.9312013759836;3548.0215836315892;3565.575408722068;3577.94633080504;195064;197970;198278;198406;198572;52173.13047782408;54761.1785823213;55528.44471555233;55547;61045.38954610486;55107.72446137744;55361.72319138378;55399.44600553943;55464;55482.72258638681;15562.377504899678;15782.921085394499;15783.684326313409;15786.763198552031;15796.210189490479;9989.950050249703;12019.098567607465;12078.094142939315;12125.09061820367;12581.496740130293;19495;19571.608567828564;19663.213471460982;19767.505812354808;19832.60334793296;7298.525595836254;7592;7669.578173200416;7721.343685786659;7786.454948153575;841.8989721233492;863.5346086921874;939.6945992552447;985.1478471122427;995.8954309797512;25763.48473030529;26768.27197730834;27313.726862731517;27449.039283624978;27479.450410991667;978.7553111722069;986.7631768375682;1008.5007921079113;1076.838474228872;1096.3586302013412;13658.04393692432;13675.111117777313;13919.582412527641;14197;14374.784378234335;289708;292852;293840;294292;295857;49431.75284123556;49945.500544994815;49953.50046499561;50041;50061.49938500641;953.9332246742662;1031.293563908725;1141.2125633312987;1263.9052071094704;1275.8532768731716;24700.50598988046;24903.505789652678;25008.37479063038;25029.624555631315;25091.99632014699;36024.27951441009;36369.27261454809;36381.45427818638;36439.27121457609;36454.635453645125;164509;165118.17440912718;165293;165541.17229413777;165570;30694.930506949127;41195.7940210297;41525.58474415338;42058.369124462544;42761.358579621956;37713.43429848499;38466;38602.6139738599;38821;38913.2217355657;34638.82680586581;35311.82344088263;35617.64382356143;35793.28413431769;35993.64006359903;34276.828615856764;34704;34805.825970870996;34967.65032349644;35050.64949350474;34068.318633626695;34730;34763.826180868935;35019;35259;30583.388332233677;30988.535171971987;31122.53316200304;31142.37715245637;31194;24342.269731908073;24639.26082217536;24775.067155310924;25094.37264068413;25124.874375628006 12:22:24 INFO - PROCESS | 5324 | |2;jquery.html;350.9105178179565;358.24946736586855;361.1188699573042;367.8951498822836;371.41131306878594;15443.768343474843;15694.372225110996;16265.99999999997;16510.83489165108;16606.50180494584;16105.516834494954;16533.66932661346;16622;16634.334626614953;16638.0849053302;4999.600031997432;5020.849374518752;5064.620153488485;5104.33643626328;5159.071367153911;5081.237814327844;5084.974575127119;5121.5390614844655;5146.6911985281;5148.768305426265;5016.849494515152;5039.19372900336;5060.190369540875;5088.465711100337;5088.898222035557;5160.148575485059;5172.353455818023;5197.246399272122;5202.4277329493725;5206.557442617363;4968.826091086795;5001.699898006095;5003.17447621142;5006.799728010911;5008.273800298973;11596.246243994114;18817.717734233996;19345.613087738166;19421.126049327813;19444.513887152792;1802.2520653928605;1991.2134706790882;2116.0900812650552;2241.674957131207;2390.8804559771943;9588.328816982814;11877.762444751057;11891.881081189164;12981.286029268387;13160.934195329059;1641.5075477356866;1669.1070277401532;1761.9868575569099;1779.813119622434;1816.8909865407986;44021.33967990483;52447.47552524502;53394.46605533934;55843.44156558423;59238.40761592372;9078.54607269634;9175.678851240174;9254.131219322031;14271.429142834171;14516.491922782652;23773.881130594236;23775.405614859767;23947.760522394903;24027;24145.637815432783;8703.129687031245;8788.340874434443;8994.640214391351;9111;9193.95403022994;7785.883211751829;7817.179196184319;7892.565908875067;8001.1198768135455;8036.397270204641;7771.417143714244;7778.713984434554;7886.802829929297;7901.249381308767;7909.723159689498;2913.716836250708;2947.7347038766616;3090.459169645303;3097.4269760094453;3144.7641426893074;814.8573999550055;861.6811779641447;937.0041810942785;943.740471370365;949.1647350331664;16101.27544260511;16186.919065404598;16201.837981620269;16247.512574622544;16418.917905410395;849.1211595998236;871.54679566625;880.4761167105562;887.3211992825494;965.605298858834;9038.367314288069;9313.20837728787;9463.337566370288;9524.571394287274;9583.281253905845;381801;383561;405627;417817;456082;67391.66304168546;70017;70320.2967970324;70458;70520;972.2027937091517;991.7421470417744;994.2741798487145;1003.7390278527636;1010.1918465227935;12317.630471085882;14842.40630374773;14904.403823847359;15211.239438027833;15245.923770381522;31105;31133.688663113986;32003.67996320007;34711.30577388489;34763.304733904675;37514;39541.60458395379;40068.7996560027;40332.1933561333;40479.392809107296;7289.927100728924;7521.435892308208;7594.696212151673;7726.343260822893;7768.7669369918995;8509.404341696021;11659;11702.122340824642;11713.297202167898;11799.410029498662;9827.901720982698;10163.695089147337;10290.691279261635;10382.584696612052;10585.9470702646;9830.459324737209;10232.795344092927;10261.28171028021;10310;10412.531436085546;9657.613695452103;9833.4099954003;10155.54300056514;10259.692209233735;10731.678049658523;7106.5736055836815;7222.313880181585;7241.203467618663;7310.96344518274;7380.667869945973;7681.961590192013;9142.268618510636;10136.391816491034;10178.08397244222;10283.588656453658 12:22:24 INFO - PROCESS | 5324 | |3;mootools.html;1297.5523444411674;1407.5214427094786;1432.240912316472;1592.7929369182004;1746.685596592613;6443.774467893625;7074.9292507074915;7228.02421673074;7229.4939354245225;7234.9276507234845;7144.642767861612;7297.854042919152;7311.963440182805;7312.488125831194;7316.231795661445;1820.1445320699315;2154.5583155453173;2202.284257616273;2219.3785739992745;2236.955260894781;2149.387424583994;2167.9783202167932;2170.5224850532936;2173.945651358713;2174.239016344283;2078.303768237642;2167.880766557839;2174.1738139506965;2174.4672555223992;2174.7390313162364;2029.7868723783938;2030.7055476955832;2051.323063389078;2128.4040468668795;2134.594427058854;2119.0993827623197;2134.1996751218294;2140.197425965263;2141.550274442369;2144.04589957469;7400.851982960311;7445.478816482849;7461.888071678929;7473.8505229895645;7485.625718714097;4432.423784907941;4577.198990176739;4587.311903214544;4596.241620132674;4601.493835678073;2868.512352900012;2912.37383962447;2956.1574951139037;2961.511350627144;2965.8072225305286;910.3263584947158;919.0625561926864;932.5943214701626;949.539473355422;952.0812416018506;10175.287729858914;10221.591136354537;10232.69301920936;10233.539490722935;10238.283320167591;4012.1574469361763;4123.814428350732;4157.043879907638;4195.517515485758;4197.202531519001;8717.651293948298;8756.299496040301;8758.518281494578;8762.079981601968;8804.867926980973;4058.939115913264;4554.066416384633;4589.426321709786;4597.356370108188;4601.930971035437;4104.774237416971;4202.747835129902;4203.47456567929;4233.491980962242;4249.2988656871885;3452.1714788451095;3528.770629909048;3547.5388199534414;3577.964220357815;3589.94615080774;1141.3893566941813;1168.6902970712767;1170.052257671272;1172.935488548121;1183.6922400175845;986.980260394788;1008.7226012846379;1155.641751057175;1163.953441862333;1178.675864137369;6677.165354330708;6715.4627629790475;6719.328067193242;6721.798346049626;6730.596164230162;1113.799516087096;1117.3631030312645;1135.9772804543863;1142.6743378137191;1157.432857899623;5460.426655201226;5497.340319161726;5522.282103326542;5533.557315414757;5534.225208470817;8299.170082991652;8934.463932164092;8956.238719708897;9060.139286767746;9065.637374505079;9051.094890511027;9086.36395452312;9090.09099090099;9124.361294709306;9153.816923661623;7007.054047703597;7091.219965803757;7210.60341681202;7220.711171553184;7263.273672632695;6735.158105236846;6751.223609284799;6772.864542709217;6779.457643388419;6786.694598743167;7895.407844411807;8272.090070092165;8280.461769984931;8294.709685160991;8337.249647531751;8304.958475207586;8473.152684731478;8588.398812083095;8611.052784193858;8616.310695144499;6202.224721909762;6211.409916057967;6466.191726034246;6469.320721324193;6475.708593113227;7039.6832142552685;7062.223155452999;7066.57600543969;7082.61045642474;7098.893516597358;6333.714982825876;6447.677616119082;6464.450521705708;6567.2447668518735;6570.047343135314;5976.61152025117;6083.361247069171;6119.204503414706;6234.501239900887;6256.124142619946;6678.899816502659;6686.933130668631;6721.966390168018;6730.899036514358;6732.764353247613;6040.546958978006;6051.818445446644;6061.7575296987625;6132.17215675878;6160.322364539987;6207.472364848858;6211.937880621136;6245.687715614292;6256.7810126645345;6272.780452684134 12:22:24 INFO - PROCESS | 5324 | |4;prototype.html;323.65045750589366;328.5285615142271;328.6335735654746;331.5639933487464;335.9395308844407;5409.080456322425;5445.537129344006;5446.4281250468675;5470.617056806015;5496.7526461309235;5343.251944727732;5355.598330125236;5375.731213439322;5391.757370918308;5397.62216644834;3976.5029371328583;4074.5925407459313;4132.462779838632;4175.66594672427;4191.727537710054;4161.292580261363;4176.102138040321;4198.139381426816;4205.705600607958;4210.915781684364;4166.145940082291;4173.520045194796;4175.248455278049;4181.707280490367;4192.958070419288;3953.62440568147;4111.650509706678;4154.169166166748;4156.418101465767;4173.64524015459;3655.4151335786146;3662.7436079474446;3668.52309199805;3671.6879065279218;3676.963230367689;5140;5143.3313669223135;5146.099432599281;5169.948300516984;5185.585153187736;4842.249451335048;4845.636577256684;4848;4848.466668666444;4853.320535125085;5651.717414129277;5706.9727449059155;5709.286339207599;5711.742971566248;5722.113072473773;4068.4304197412384;4072.3077076897;4073.083556199861;4075.4701888754566;4080.2247572961337;5730.828075157752;5995.400459954013;6004.249468816398;6005.969970150165;6019.398060193989;4033.515978082649;4087.5094988600963;4088.7137900347284;4090.734102283342;4090.9590904091174;4152.8131234094535;4155.625993660585;4158.625723684822;4159.209750147463;4161.375793630979;4779.904401912012;4785.688930219525;4786.210275304536;4787.976060119677;4788.664793464424;5712.914306285409;5734.885302293931;5736.942630573724;5738.397468265855;5740;1436.7126574685105;1461.2109460891;1462.2688655672164;1464.436192066041;1469.2433396800657;911.7674992876906;946.3612061858219;959.4051687953513;982.0768477631146;985.9260555458369;4921.975390123026;4957.553820156203;4960.057589058068;4968.279599458058;4976.303317535548;5834.970825145932;5870.354261031283;5883.882322353615;5888.499477544371;5889.1755154278435;4958.305837182797;4963.70217786934;4964.751762411865;4968.378952630921;4976.62675299354;3128.3430479599538;3150.7951983121025;3157.0371036833985;3166.95249571252;3170.920726981844;5499.175123731472;5511.338639363222;5515.889682206333;5521.641093329001;5524.254225679562;5955.196048533479;6152.600080994721;6198;6210.968945155245;6220.25356957159;5575.330960284792;5583.134614134816;5589.720513974285;5592.3009623796215;5593.300837395325;5973.297610181077;5973.313068997121;5974.2233509643465;5986.880262394815;5988.580799344004;5866.530677545871;5872.383399743137;5877.206577112206;5878.941210587839;5885.882282354414;5386.218998245311;5557.805476808292;5559.888802223852;5568.526675232651;5570.58220633446;4025.5169379674626;4080.897977550585;4102.876913692594;4105;4105.835766569304;5951.047832346804;5958.791442299499;5960.8807823844145;5964.343922168645;5966.76132954677;5745.683987380734;5746.511546518425;5750.712464376848;5753.884922301614;5755.884882302415;5733.483986441241;5742.994975879288;5753.8561535961935;5759.164921086335;5759.366469688414;5433.1035379161995;5627;5673.06394444912;5676.176954341515;5686.459786320293;5726.0838265877255;5734.913976290276;5737.5983681141915;5776.393478684846;5777.306723193244;5635.182898479616;5637.746301416528;5643.266375371176;5652.660840349592;5654 12:22:24 INFO - PROCESS | 5324 | |5;yui.html;699.8145491444765;737.8708725972954;747.9551226926388;771.764611793403;793.7261644732572;10966.835497467535;11133.387663678495;11189.216754827165;11193.72015699608;11203.831942520868;10796.622118225863;10812.621558245442;10829.458527073653;10847.620333288316;11694.707632309197;811.0956283743627;824.7443292579289;826.099551488877;826.8181000179981;827.065416079829;798.4490701416033;813.6541969662869;814.4543156085407;814.6456291513181;815.4699445360534;849.0193826130828;855.670566831768;856.1866227084295;856.6830272799073;857.0529564830865;844.9619767110464;846.4921047371589;847.656699036891;849.9362547808909;851.8509260879383;624.2197253433209;625.6652690810395;625.8466675664446;625.8560531077832;626.2078470734524;11812.586559470463;11871.406429678482;11872.52509899603;11879.940600296943;11888.454500914826;12037.819432708517;12053.93973030138;12306.692332691664;12415.193012454161;12446.937765311206;9639.132478077006;9645.42127472354;9732.805343893153;9748.561314740853;9874.259430542737;3338.599368075822;3356.4294070007913;3377.864885404581;3480.5475288212624;3481.1993241554333;43671.78164109159;43719.344209836876;43939;44028.55971440276;44615.77692111551;9824.410535367759;9864.210863130933;9922.702318930444;10022.699319020441;10048.748781280381;17704.911475442797;17719.73420398695;17779.73330400045;17785.46643600694;17806.55483612894;6483.805485835433;6496.740130394731;6597.274299827015;6620.106285651375;6836.077129587442;3308.6856748608843;3330.2506935939705;3360.0927749507496;3387.2548039431285;3432.5880894292345;2785;2820.548712206037;2820.7038260982713;2823.858807059639;2824.632797736281;496.82996543141104;502.9270755740397;515.4175781367031;516.1122868665889;516.9379674439091;491.2017970797454;592.1059200607115;606.7239406070228;623.429561950819;632.3897438971322;8062.234087761653;8249.628766705513;8331.50010999342;8335.791605209919;8550.315974722007;467.927471241958;492.8669259299969;509.48541972607933;516.5015759791819;570.3327107284487;3732.122951106488;4261.97869010653;4278.101598664315;4300.935485967713;4342.934855977162;45918.770406148426;49244.50755492471;49303.260451093265;53047;53389;36566.63433365685;37207.627923720414;39743.20513589712;40296.395554066716;40331.395029074585;42129.57870421318;43118.568814312086;43280.783596082445;43624.56375436269;43644.345334820006;8543.658253669784;8795.208431241219;8830.337724670548;8887.422317549339;8960;31893.8405307972;32240.19399515031;33357;33982.320353593284;34127.658723412445;39659.60340396674;43043;43120.35319470148;45005.54994450013;45800.083998320515;10383.273170877967;10432.165426765689;10517.21120915919;10721.839172412576;10887.074598658886;11933.28400295985;11999;12061.698457538632;12143.089268304735;12236.388180591113;11056.668299951014;11218.382988935688;11362.14783891195;11431.59989400367;11546.94226528862;11019.329827168101;11102.167337449886;11341.319520828776;11347.37589432589;11416.31502109876;11133.276337038067;11313.547458101584;11382.260153090023;11401.372924489233;11907.76184476323;8448.91551084506;8597.699080532151;8635.87046194295;8700.825983480421;8756.343274254585;8577.571121444027;8717.433366831136;8810.295176386002;8839.955800220958;8970.596323165342 12:22:24 INFO - PROCESS | 5324 | __end_tp_report 12:22:24 INFO - PROCESS | 5324 | __start_cc_report 12:22:24 INFO - PROCESS | 5324 | _x_x_mozilla_cycle_collect,909 12:22:24 INFO - PROCESS | 5324 | __end_cc_report 12:22:24 INFO - PROCESS | 5324 | __startTimestamp1459624944313__endTimestamp 12:22:24 INFO - PROCESS | 5324 | 12:22:24 INFO - PROCESS | 5324 | ------- Summary: start ------- 12:22:24 INFO - PROCESS | 5324 | Number of tests: 6 12:22:24 INFO - PROCESS | 5324 | 12:22:24 INFO - PROCESS | 5324 | [#0] dojo.html Cycles:165 Average:4692.76 Median:4824.95 stddev:482.90 (10.0%) stddev-sans-first:456.56 12:22:24 INFO - PROCESS | 5324 | Values: 2633.7 2666.1 2688.8 2705.0 2722.2 4650.2 4687.4 4702.6 4744.7 4772.2 4728.5 4728.9 4796.0 4796.9 4801.2 4254.3 4275.8 4283.8 4335.3 4472.8 4440.3 4493.7 4530.2 4531.0 4540.0 4285.7 4359.6 4373.7 4428.1 4440.5 4302.8 4313.8 4319.8 4322.5 4324.5 4285.3 4288.1 4288.5 4291.7 4294.5 4562.5 4613.3 4615.6 4657.6 4669.9 5065.2 5088.9 5095.9 5116.6 5132.3 5004.5 5005.0 5108.2 5115.6 5127.9 4799.9 4803.4 4806.9 4825.0 4855.2 5211.5 5253.1 5267.6 5281.6 5329.3 4861.9 4975.2 5061.3 5065.8 5067.9 5068.8 5087.9 5090.0 5092.4 5129.9 5037.8 5038.8 5039.5 5042.3 5077.9 4851.0 4906.7 4942.2 4957.8 5033.1 4370.8 4373.9 4386.0 4388.6 4438.0 3809.7 3851.7 3869.9 3876.3 3880.9 4260.6 4349.3 4350.0 4379.2 4431.3 5018.5 5044.1 5056.0 5058.1 5080.4 4316.0 4319.7 4333.7 4364.1 4370.3 4446.1 4556.7 4577.0 4656.3 4666.4 4751.2 4762.9 4763.3 4798.0 4808.8 5052.5 5059.8 5061.7 5080.5 5085.3 4719.1 4780.7 4804.1 4880.9 4887.2 4991.6 4999.2 5001.9 5009.6 5072.0 5100.1 5118.6 5120.1 5120.7 5120.9 4842.7 4872.3 4909.1 4956.1 4973.1 4897.8 4923.0 4925.4 4928.8 4984.0 4696.8 4841.5 4867.0 4867.3 4913.0 4958.1 4967.6 4971.5 5040.7 5049.4 4843.7 4861.2 4865.0 4868.0 4911.6 12:22:24 INFO - PROCESS | 5324 | 12:22:24 INFO - PROCESS | 5324 | [#1] ext.html Cycles:180 Average:39079.60 Median:19685.62 stddev:58770.93 (298.5%) stddev-sans-first:58864.44 12:22:24 INFO - PROCESS | 5324 | Values: 511.1 541.7 546.0 571.5 583.9 35154.3 35953.8 36051.0 36064.5 36119.3 37904.2 38387.0 38423.2 38468.2 38523.6 7692.0 7894.4 7900.5 7910.4 7922.4 7894.7 8024.3 8043.8 8044.6 8066.3 8041.8 8103.8 8112.5 8113.1 8115.2 7971.6 8048.8 8055.5 8056.3 8058.0 7969.6 8070.7 8081.6 8087.5 8103.8 38852.2 39153.1 39210.4 39225.8 39255.2 2855.6 2938.6 3143.4 3207.9 3554.7 29332.9 29771.6 29915.4 30251.5 30639.2 3425.0 3439.9 3548.0 3565.6 3577.9 195064.0 197970.0 198278.0 198406.0 198572.0 52173.1 54761.2 55528.4 55547.0 61045.4 55107.7 55361.7 55399.4 55464.0 55482.7 15562.4 15782.9 15783.7 15786.8 15796.2 9990.0 12019.1 12078.1 12125.1 12581.5 19495.0 19571.6 19663.2 19767.5 19832.6 7298.5 7592.0 7669.6 7721.3 7786.5 841.9 863.5 939.7 985.1 995.9 25763.5 26768.3 27313.7 27449.0 27479.5 978.8 986.8 1008.5 1076.8 1096.4 13658.0 13675.1 13919.6 14197.0 14374.8 289708.0 292852.0 293840.0 294292.0 295857.0 49431.8 49945.5 49953.5 50041.0 50061.5 953.9 1031.3 1141.2 1263.9 1275.9 24700.5 24903.5 25008.4 25029.6 25092.0 36024.3 36369.3 36381.5 36439.3 36454.6 164509.0 165118.2 165293.0 165541.2 165570.0 30694.9 41195.8 41525.6 42058.4 42761.4 37713.4 38466.0 38602.6 38821.0 38913.2 34638.8 35311.8 35617.6 35793.3 35993.6 34276.8 34704.0 34805.8 34967.7 35050.6 34068.3 34730.0 34763.8 35019.0 35259.0 30583.4 30988.5 31122.5 31142.4 31194.0 24342.3 24639.3 24775.1 25094.4 25124.9 12:22:24 INFO - PROCESS | 5324 | 12:22:24 INFO - PROCESS | 5324 | [#2] jquery.html Cycles:180 Average:24103.98 Median:250051.67 stddev:66995.81 (26.8%) stddev-sans-first:67160.01 12:22:24 INFO - PROCESS | 5324 | Values: 350.9 358.2 361.1 367.9 371.4 15443.8 15694.4 16266.0 16510.8 16606.5 16105.5 16533.7 16622.0 16634.3 16638.1 4999.6 5020.8 5064.6 5104.3 5159.1 5081.2 5085.0 5121.5 5146.7 5148.8 5016.8 5039.2 5060.2 5088.5 5088.9 5160.1 5172.4 5197.2 5202.4 5206.6 4968.8 5001.7 5003.2 5006.8 5008.3 11596.2 18817.7 19345.6 19421.1 19444.5 1802.3 1991.2 2116.1 2241.7 2390.9 9588.3 11877.8 11891.9 12981.3 13160.9 1641.5 1669.1 1762.0 1779.8 1816.9 44021.3 52447.5 53394.5 55843.4 59238.4 9078.5 9175.7 9254.1 14271.4 14516.5 23773.9 23775.4 23947.8 24027.0 24145.6 8703.1 8788.3 8994.6 9111.0 9194.0 7785.9 7817.2 7892.6 8001.1 8036.4 7771.4 7778.7 7886.8 7901.2 7909.7 2913.7 2947.7 3090.5 3097.4 3144.8 814.9 861.7 937.0 943.7 949.2 16101.3 16186.9 16201.8 16247.5 16418.9 849.1 871.5 880.5 887.3 965.6 9038.4 9313.2 9463.3 9524.6 9583.3 381801.0 383561.0 405627.0 417817.0 456082.0 67391.7 70017.0 70320.3 70458.0 70520.0 972.2 991.7 994.3 1003.7 1010.2 12317.6 14842.4 14904.4 15211.2 15245.9 31105.0 31133.7 32003.7 34711.3 34763.3 37514.0 39541.6 40068.8 40332.2 40479.4 7289.9 7521.4 7594.7 7726.3 7768.8 8509.4 11659.0 11702.1 11713.3 11799.4 9827.9 10163.7 10290.7 10382.6 10585.9 9830.5 10232.8 10261.3 10310.0 10412.5 9657.6 9833.4 10155.5 10259.7 10731.7 7106.6 7222.3 7241.2 7311.0 7380.7 7682.0 9142.3 10136.4 10178.1 10283.6 12:22:24 INFO - PROCESS | 5324 | 12:22:24 INFO - PROCESS | 5324 | [#3] mootools.html Cycles:180 Average:5194.87 Median:6146.25 stddev:2692.67 (43.8%) stddev-sans-first:2684.29 12:22:24 INFO - PROCESS | 5324 | Values: 1297.6 1407.5 1432.2 1592.8 1746.7 6443.8 7074.9 7228.0 7229.5 7234.9 7144.6 7297.9 7312.0 7312.5 7316.2 1820.1 2154.6 2202.3 2219.4 2237.0 2149.4 2168.0 2170.5 2173.9 2174.2 2078.3 2167.9 2174.2 2174.5 2174.7 2029.8 2030.7 2051.3 2128.4 2134.6 2119.1 2134.2 2140.2 2141.6 2144.0 7400.9 7445.5 7461.9 7473.9 7485.6 4432.4 4577.2 4587.3 4596.2 4601.5 2868.5 2912.4 2956.2 2961.5 2965.8 910.3 919.1 932.6 949.5 952.1 10175.3 10221.6 10232.7 10233.5 10238.3 4012.2 4123.8 4157.0 4195.5 4197.2 8717.7 8756.3 8758.5 8762.1 8804.9 4058.9 4554.1 4589.4 4597.4 4601.9 4104.8 4202.7 4203.5 4233.5 4249.3 3452.2 3528.8 3547.5 3578.0 3589.9 1141.4 1168.7 1170.1 1172.9 1183.7 987.0 1008.7 1155.6 1164.0 1178.7 6677.2 6715.5 6719.3 6721.8 6730.6 1113.8 1117.4 1136.0 1142.7 1157.4 5460.4 5497.3 5522.3 5533.6 5534.2 8299.2 8934.5 8956.2 9060.1 9065.6 9051.1 9086.4 9090.1 9124.4 9153.8 7007.1 7091.2 7210.6 7220.7 7263.3 6735.2 6751.2 6772.9 6779.5 6786.7 7895.4 8272.1 8280.5 8294.7 8337.2 8305.0 8473.2 8588.4 8611.1 8616.3 6202.2 6211.4 6466.2 6469.3 6475.7 7039.7 7062.2 7066.6 7082.6 7098.9 6333.7 6447.7 6464.5 6567.2 6570.0 5976.6 6083.4 6119.2 6234.5 6256.1 6678.9 6686.9 6722.0 6730.9 6732.8 6040.5 6051.8 6061.8 6132.2 6160.3 6207.5 6211.9 6245.7 6256.8 6272.8 12:22:24 INFO - PROCESS | 5324 | 12:22:24 INFO - PROCESS | 5324 | [#4] prototype.html Cycles:180 Average:4734.85 Median:5403.35 stddev:1398.85 (25.9%) stddev-sans-first:1363.03 12:22:24 INFO - PROCESS | 5324 | Values: 323.7 328.5 328.6 331.6 335.9 5409.1 5445.5 5446.4 5470.6 5496.8 5343.3 5355.6 5375.7 5391.8 5397.6 3976.5 4074.6 4132.5 4175.7 4191.7 4161.3 4176.1 4198.1 4205.7 4210.9 4166.1 4173.5 4175.2 4181.7 4193.0 3953.6 4111.7 4154.2 4156.4 4173.6 3655.4 3662.7 3668.5 3671.7 3677.0 5140.0 5143.3 5146.1 5169.9 5185.6 4842.2 4845.6 4848.0 4848.5 4853.3 5651.7 5707.0 5709.3 5711.7 5722.1 4068.4 4072.3 4073.1 4075.5 4080.2 5730.8 5995.4 6004.2 6006.0 6019.4 4033.5 4087.5 4088.7 4090.7 4091.0 4152.8 4155.6 4158.6 4159.2 4161.4 4779.9 4785.7 4786.2 4788.0 4788.7 5712.9 5734.9 5736.9 5738.4 5740.0 1436.7 1461.2 1462.3 1464.4 1469.2 911.8 946.4 959.4 982.1 985.9 4922.0 4957.6 4960.1 4968.3 4976.3 5835.0 5870.4 5883.9 5888.5 5889.2 4958.3 4963.7 4964.8 4968.4 4976.6 3128.3 3150.8 3157.0 3167.0 3170.9 5499.2 5511.3 5515.9 5521.6 5524.3 5955.2 6152.6 6198.0 6211.0 6220.3 5575.3 5583.1 5589.7 5592.3 5593.3 5973.3 5973.3 5974.2 5986.9 5988.6 5866.5 5872.4 5877.2 5878.9 5885.9 5386.2 5557.8 5559.9 5568.5 5570.6 4025.5 4080.9 4102.9 4105.0 4105.8 5951.0 5958.8 5960.9 5964.3 5966.8 5745.7 5746.5 5750.7 5753.9 5755.9 5733.5 5743.0 5753.9 5759.2 5759.4 5433.1 5627.0 5673.1 5676.2 5686.5 5726.1 5734.9 5737.6 5776.4 5777.3 5635.2 5637.7 5643.3 5652.7 5654.0 12:22:24 INFO - PROCESS | 5324 | 12:22:24 INFO - PROCESS | 5324 | [#5] yui.html Cycles:180 Average:12615.65 Median:43695.56 stddev:14149.58 (32.4%) stddev-sans-first:14160.98 12:22:24 INFO - PROCESS | 5324 | Values: 699.8 737.9 748.0 771.8 793.7 10966.8 11133.4 11189.2 11193.7 11203.8 10796.6 10812.6 10829.5 10847.6 11694.7 811.1 824.7 826.1 826.8 827.1 798.4 813.7 814.5 814.6 815.5 849.0 855.7 856.2 856.7 857.1 845.0 846.5 847.7 849.9 851.9 624.2 625.7 625.8 625.9 626.2 11812.6 11871.4 11872.5 11879.9 11888.5 12037.8 12053.9 12306.7 12415.2 12446.9 9639.1 9645.4 9732.8 9748.6 9874.3 3338.6 3356.4 3377.9 3480.5 3481.2 43671.8 43719.3 43939.0 44028.6 44615.8 9824.4 9864.2 9922.7 10022.7 10048.7 17704.9 17719.7 17779.7 17785.5 17806.6 6483.8 6496.7 6597.3 6620.1 6836.1 3308.7 3330.3 3360.1 3387.3 3432.6 2785.0 2820.5 2820.7 2823.9 2824.6 496.8 502.9 515.4 516.1 516.9 491.2 592.1 606.7 623.4 632.4 8062.2 8249.6 8331.5 8335.8 8550.3 467.9 492.9 509.5 516.5 570.3 3732.1 4262.0 4278.1 4300.9 4342.9 45918.8 49244.5 49303.3 53047.0 53389.0 36566.6 37207.6 39743.2 40296.4 40331.4 42129.6 43118.6 43280.8 43624.6 43644.3 8543.7 8795.2 8830.3 8887.4 8960.0 31893.8 32240.2 33357.0 33982.3 34127.7 39659.6 43043.0 43120.4 45005.5 45800.1 10383.3 10432.2 10517.2 10721.8 10887.1 11933.3 11999.0 12061.7 12143.1 12236.4 11056.7 11218.4 11362.1 11431.6 11546.9 11019.3 11102.2 11341.3 11347.4 11416.3 11133.3 11313.5 11382.3 11401.4 11907.8 8448.9 8597.7 8635.9 8700.8 8756.3 8577.6 8717.4 8810.3 8840.0 8970.6 12:22:24 INFO - PROCESS | 5324 | -------- Summary: end -------- 12:22:24 INFO - PROCESS | 5324 | 12:22:25 INFO - TEST-INFO | 5324: exit 0 12:22:25 INFO - TEST-OK | dromaeo_css | took 1116373ms 12:22:25 INFO - TEST-START | kraken 12:22:25 INFO - operating with platform_type : linux_ 12:22:25 INFO - Initialising browser for kraken test... 12:22:25 INFO - TEST-INFO | started process 5499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLB4F39/profile http://localhost:57107/getInfo.html) 12:22:29 INFO - PROCESS | 5499 | __metrics Screen width/height:1600/1200 12:22:29 INFO - PROCESS | 5499 | colorDepth:24 12:22:29 INFO - PROCESS | 5499 | Browser inner width/height: 1024/697 12:22:29 INFO - PROCESS | 5499 | __metrics 12:22:30 ERROR - PROCESS | 5499 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:22:30 INFO - TEST-INFO | 5499: exit 0 12:22:30 INFO - Browser initialized. 12:22:30 INFO - Running cycle 1/1 for kraken test... 12:22:30 INFO - TEST-INFO | started process 5578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLB4F39/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:22:42 INFO - PROCESS | 5578 | RSS: Main: 155439104 12:22:42 INFO - PROCESS | 5578 | 12:22:45 INFO - PROCESS | 5578 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57107/tests/kraken/driver.html?testName=audio-beat-detection) 12:22:46 INFO - PROCESS | 5578 | RSS: Main: 195608576 12:22:46 INFO - PROCESS | 5578 | 12:22:49 INFO - PROCESS | 5578 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57107/tests/kraken/driver.html?testName=audio-dft) 12:22:49 INFO - PROCESS | 5578 | RSS: Main: 185389056 12:22:49 INFO - PROCESS | 5578 | 12:22:52 INFO - PROCESS | 5578 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57107/tests/kraken/driver.html?testName=audio-fft) 12:22:53 INFO - PROCESS | 5578 | RSS: Main: 172150784 12:22:53 INFO - PROCESS | 5578 | 12:22:55 INFO - PROCESS | 5578 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57107/tests/kraken/driver.html?testName=audio-oscillator) 12:22:55 INFO - PROCESS | 5578 | RSS: Main: 172593152 12:22:55 INFO - PROCESS | 5578 | 12:22:58 INFO - PROCESS | 5578 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57107/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:22:58 INFO - PROCESS | 5578 | RSS: Main: 174755840 12:22:58 INFO - PROCESS | 5578 | 12:23:01 INFO - PROCESS | 5578 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57107/tests/kraken/driver.html?testName=imaging-darkroom) 12:23:02 INFO - PROCESS | 5578 | RSS: Main: 175005696 12:23:02 INFO - PROCESS | 5578 | 12:23:05 INFO - PROCESS | 5578 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57107/tests/kraken/driver.html?testName=imaging-desaturate) 12:23:06 INFO - PROCESS | 5578 | RSS: Main: 175820800 12:23:06 INFO - PROCESS | 5578 | 12:23:09 INFO - PROCESS | 5578 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57107/tests/kraken/driver.html?testName=json-parse-financial) 12:23:09 INFO - PROCESS | 5578 | RSS: Main: 175665152 12:23:09 INFO - PROCESS | 5578 | 12:23:11 INFO - PROCESS | 5578 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57107/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:23:12 INFO - PROCESS | 5578 | RSS: Main: 184692736 12:23:12 INFO - PROCESS | 5578 | 12:23:14 INFO - PROCESS | 5578 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:23:14 INFO - PROCESS | 5578 | RSS: Main: 181694464 12:23:14 INFO - PROCESS | 5578 | 12:23:16 INFO - PROCESS | 5578 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:23:17 INFO - PROCESS | 5578 | RSS: Main: 197459968 12:23:17 INFO - PROCESS | 5578 | 12:23:19 INFO - PROCESS | 5578 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:23:20 INFO - PROCESS | 5578 | RSS: Main: 200712192 12:23:20 INFO - PROCESS | 5578 | 12:23:22 INFO - PROCESS | 5578 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:23:23 INFO - PROCESS | 5578 | RSS: Main: 199258112 12:23:23 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57107/tests/kraken/driver.html?testName=ai-astar) 12:23:25 INFO - PROCESS | 5578 | RSS: Main: 261816320 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | __start_tp_report 12:23:25 INFO - PROCESS | 5578 | _x_x_mozilla_page_load 12:23:25 INFO - PROCESS | 5578 | _x_x_mozilla_page_load_details 12:23:25 INFO - PROCESS | 5578 | |i|pagename|runs| 12:23:25 INFO - PROCESS | 5578 | |0;ai-astar;111;113;110;114;113;113;101;112;111;113 12:23:25 INFO - PROCESS | 5578 | |1;audio-beat-detection;164;139;165;182;139;165;166;132;169;133 12:23:25 INFO - PROCESS | 5578 | |2;audio-dft;161;160;159;161;162;165;164;160;162;161 12:23:25 INFO - PROCESS | 5578 | |3;audio-fft;77;74;106;105;73;73;73;116;100;75 12:23:25 INFO - PROCESS | 5578 | |4;audio-oscillator;94;95;141;92;94;94;138;93;93;144 12:23:25 INFO - PROCESS | 5578 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;116;117;116 12:23:25 INFO - PROCESS | 5578 | |6;imaging-darkroom;145;146;146;145;146;146;146;148;146;146 12:23:25 INFO - PROCESS | 5578 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;96;95 12:23:25 INFO - PROCESS | 5578 | |8;json-parse-financial;63;66;65;64;64;65;65;75;63;62 12:23:25 INFO - PROCESS | 5578 | |9;json-stringify-tinderbox;64;63;64;64;65;64;64;63;64;64 12:23:25 INFO - PROCESS | 5578 | |10;stanford-crypto-aes;83;83;81;82;83;81;81;83;80;81 12:23:25 INFO - PROCESS | 5578 | |11;stanford-crypto-ccm;125;127;122;114;112;124;124;114;116;115 12:23:25 INFO - PROCESS | 5578 | |12;stanford-crypto-pbkdf2;151;142;142;144;140;130;143;142;142;143 12:23:25 INFO - PROCESS | 5578 | |13;stanford-crypto-sha256-iterative;69;67;67;66;68;66;68;70;68;66 12:23:25 INFO - PROCESS | 5578 | __end_tp_report 12:23:25 INFO - PROCESS | 5578 | __start_cc_report 12:23:25 INFO - PROCESS | 5578 | _x_x_mozilla_cycle_collect,1159 12:23:25 INFO - PROCESS | 5578 | __end_cc_report 12:23:25 INFO - PROCESS | 5578 | __startTimestamp1459625005564__endTimestamp 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | ------- Summary: start ------- 12:23:25 INFO - PROCESS | 5578 | Number of tests: 14 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | [#0] ai-astar Cycles:10 Average:111.10 Median:113.00 stddev:3.75 (3.3%) stddev-sans-first:3.98 12:23:25 INFO - PROCESS | 5578 | Values: 111.0 113.0 110.0 114.0 113.0 113.0 101.0 112.0 111.0 113.0 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:165.00 stddev:17.80 (10.8%) stddev-sans-first:18.60 12:23:25 INFO - PROCESS | 5578 | Values: 164.0 139.0 165.0 182.0 139.0 165.0 166.0 132.0 169.0 133.0 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.84 (1.1%) stddev-sans-first:1.94 12:23:25 INFO - PROCESS | 5578 | Values: 161.0 160.0 159.0 161.0 162.0 165.0 164.0 160.0 162.0 161.0 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | [#3] audio-fft Cycles:10 Average:87.20 Median:73.00 stddev:17.31 (23.7%) stddev-sans-first:17.96 12:23:25 INFO - PROCESS | 5578 | Values: 77.0 74.0 106.0 105.0 73.0 73.0 73.0 116.0 100.0 75.0 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:93.50 stddev:22.97 (24.6%) stddev-sans-first:23.81 12:23:25 INFO - PROCESS | 5578 | Values: 94.0 95.0 141.0 92.0 94.0 94.0 138.0 93.0 93.0 144.0 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 12:23:25 INFO - PROCESS | 5578 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 12:23:25 INFO - PROCESS | 5578 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 146.0 148.0 146.0 146.0 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 12:23:25 INFO - PROCESS | 5578 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.00 stddev:3.65 (5.6%) stddev-sans-first:3.78 12:23:25 INFO - PROCESS | 5578 | Values: 63.0 66.0 65.0 64.0 64.0 65.0 65.0 75.0 63.0 62.0 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 12:23:25 INFO - PROCESS | 5578 | Values: 64.0 63.0 64.0 64.0 65.0 64.0 64.0 63.0 64.0 64.0 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.50 stddev:1.14 (1.4%) stddev-sans-first:1.12 12:23:25 INFO - PROCESS | 5578 | Values: 83.0 83.0 81.0 82.0 83.0 81.0 81.0 83.0 80.0 81.0 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:123.00 stddev:5.60 (4.6%) stddev-sans-first:5.55 12:23:25 INFO - PROCESS | 5578 | Values: 125.0 127.0 122.0 114.0 112.0 124.0 124.0 114.0 116.0 115.0 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.90 Median:142.50 stddev:5.11 (3.6%) stddev-sans-first:4.23 12:23:25 INFO - PROCESS | 5578 | Values: 151.0 142.0 142.0 144.0 140.0 130.0 143.0 142.0 142.0 143.0 12:23:25 INFO - PROCESS | 5578 | 12:23:25 INFO - PROCESS | 5578 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.32 12:23:25 INFO - PROCESS | 5578 | Values: 69.0 67.0 67.0 66.0 68.0 66.0 68.0 70.0 68.0 66.0 12:23:25 INFO - PROCESS | 5578 | -------- Summary: end -------- 12:23:25 INFO - PROCESS | 5578 | 12:23:26 INFO - TEST-INFO | 5578: exit 0 12:23:26 INFO - TEST-OK | kraken | took 61449ms 12:23:26 INFO - SUITE-END | took 1177s 12:23:26 INFO - Completed test suite (00:19:37) 12:23:26 INFO - javascript benchmark 12:23:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2633.683957925049, 2666.0935282004116, 2688.8386696798193, 2704.999150314385, 2722.1833449965006, 4650.23271160259, 4687.414073240845, 4702.600278976287, 4744.69159504632, 4772.164871147548, 4728.503507131744, 4728.929066064012, 4795.976020119894, 4796.920692844108, 4801.159797035522, 4254.276772948606, 4275.828966841323, 4283.828646854122, 4335.284678028122, 4472.7539985300955, 4440.267355886275, 4493.73037617744, 4530.184566777995, 4530.97734511327, 4539.9773001134945, 4285.657147428198, 4359.564043595647, 4373.737575745434, 4428.136513379892, 4440.467143942731, 4302.763348015857, 4313.762743049131, 4319.82720691172, 4322.502912165079, 4324.524302326741, 4285.314349704033, 4288.056627541967, 4288.50682171548, 4291.678124140702, 4294.484661840599, 4562.4753153387455, 4613.331066995301, 4615.561521655437, 4657.604103651193, 4669.859904202879, 5065.189569668835, 5088.92366614501, 5095.8980820383385, 5116.565091967187, 5132.28148059272, 5004.5495905368325, 5004.9749751251375, 5108.233764935252, 5115.616328775357, 5127.9230811537855, 4799.880002999953, 4803.447603525639, 4806.927896081562, 4824.951750482521, 4855.150348688965, 5211.478852114834, 5253.054450198924, 5267.578593712494, 5281.577473802164, 5329.25390445338, 4861.9027619447415, 4975.228839529878, 5061.2661164131, 5065.848024559269, 5067.8986420271385, 5068.847934561895, 5087.87280317995, 5089.9745501272255, 5092.439831618519, 5129.8717532061255, 5037.79848806051, 5038.773255203525, 5039.546440820343, 5042.268871013683, 5077.949220507748, 4850.95149048512, 4906.730129842822, 4942.159832828428, 4957.801687932514, 5033.144365457881, 4370.825166993284, 4373.890652733643, 4386.035072284092, 4388.626966707866, 4437.955620443819, 3809.675461032443, 3851.6533511983494, 3869.903252418656, 3876.341022026262, 3880.941785873214, 4260.573942605776, 4349.282368409177, 4349.978250108792, 4379.167958087953, 4431.313146462304, 5018.473060328686, 5044.066847633199, 5056.0, 5058.064258112261, 5080.415752188472, 4316.028893499, 4319.654427645781, 4333.674974376934, 4364.08354245612, 4370.2570563004365, 4446.088551846864, 4556.726596404226, 4577.038821847449, 4656.301554766812, 4666.440027196758, 4751.216049351888, 4762.928556071731, 4763.285507173951, 4797.976010119927, 4808.807647694053, 5052.469490703424, 5059.797608095635, 5061.721605311596, 5080.46655101209, 5085.288059671575, 4719.126961512131, 4780.737059461763, 4804.135255654016, 4880.853574392774, 4887.193613053949, 4991.6006719463085, 4999.225120106389, 5001.899962000813, 5009.649324547247, 5071.974640126923, 5100.107481190851, 5118.641695081308, 5120.103981803244, 5120.667156634956, 5120.871978200575, 4842.7336496493035, 4872.317875497362, 4909.0672772173175, 4956.083124621812, 4973.129702302155, 4897.755112244445, 4923.0, 4925.433575138905, 4928.753562321941, 4983.9501604984935, 4696.812127514998, 4841.540053694894, 4866.95133048665, 4867.300455535666, 4913.0, 4958.057968985881, 4967.552920237196, 4971.453140154508, 5040.697558146523, 5049.368828896388, 4843.660943734046, 4861.246506791453, 4864.978354545444, 4867.95132048675, 4911.582515486224], "unit": "score", "name": "dojo.html", "value": 4662.661600728031}, {"lowerIsBetter": false, "replicates": [511.08770844043386, 541.6506353402053, 545.9754311056001, 571.5313442976761, 583.9124131380293, 35154.296914061706, 35953.82023089884, 36051.0, 36064.45903311452, 36119.277614447696, 37904.24191516168, 38387.00968874042, 38423.231535369276, 38468.23063538728, 38523.614763852354, 7691.961540192306, 7894.368450523973, 7900.525968441883, 7910.4462687611895, 7922.445428819985, 7894.684212631488, 8024.317932975704, 8043.798905027392, 8044.597770111501, 8066.274035336818, 8041.798955026142, 8103.837923241532, 8112.513249205037, 8113.107558168596, 8115.229053239933, 7971.641276142587, 8048.839023219562, 8055.516668999879, 8056.274935255826, 8057.95971020147, 7969.641366138538, 8070.71752488666, 8081.6363263653275, 8087.514749115072, 8103.797405064862, 38852.222955541016, 39153.06352023609, 39210.41184382237, 39225.803870980744, 39255.21489570192, 2855.5859400387035, 2938.559216117578, 3143.402753476832, 3207.903762887117, 3554.662307080823, 29332.853335733398, 29771.553426698618, 29915.40169196604, 30251.546226806397, 30639.2340191497, 3425.0, 3439.9312013759836, 3548.0215836315892, 3565.575408722068, 3577.94633080504, 195064.0, 197970.0, 198278.0, 198406.0, 198572.0, 52173.13047782408, 54761.1785823213, 55528.44471555233, 55547.0, 61045.38954610486, 55107.72446137744, 55361.72319138378, 55399.44600553943, 55464.0, 55482.72258638681, 15562.377504899678, 15782.921085394499, 15783.684326313409, 15786.763198552031, 15796.210189490479, 9989.950050249703, 12019.098567607465, 12078.094142939315, 12125.09061820367, 12581.496740130293, 19495.0, 19571.608567828564, 19663.213471460982, 19767.505812354808, 19832.60334793296, 7298.525595836254, 7592.0, 7669.578173200416, 7721.343685786659, 7786.454948153575, 841.8989721233492, 863.5346086921874, 939.6945992552447, 985.1478471122427, 995.8954309797512, 25763.48473030529, 26768.27197730834, 27313.726862731517, 27449.039283624978, 27479.450410991667, 978.7553111722069, 986.7631768375682, 1008.5007921079113, 1076.838474228872, 1096.3586302013412, 13658.04393692432, 13675.111117777313, 13919.582412527641, 14197.0, 14374.784378234335, 289708.0, 292852.0, 293840.0, 294292.0, 295857.0, 49431.75284123556, 49945.500544994815, 49953.50046499561, 50041.0, 50061.49938500641, 953.9332246742662, 1031.293563908725, 1141.2125633312987, 1263.9052071094704, 1275.8532768731716, 24700.50598988046, 24903.505789652678, 25008.37479063038, 25029.624555631315, 25091.99632014699, 36024.27951441009, 36369.27261454809, 36381.45427818638, 36439.27121457609, 36454.635453645125, 164509.0, 165118.17440912718, 165293.0, 165541.17229413777, 165570.0, 30694.930506949127, 41195.7940210297, 41525.58474415338, 42058.369124462544, 42761.358579621956, 37713.43429848499, 38466.0, 38602.6139738599, 38821.0, 38913.2217355657, 34638.82680586581, 35311.82344088263, 35617.64382356143, 35793.28413431769, 35993.64006359903, 34276.828615856764, 34704.0, 34805.825970870996, 34967.65032349644, 35050.64949350474, 34068.318633626695, 34730.0, 34763.826180868935, 35019.0, 35259.0, 30583.388332233677, 30988.535171971987, 31122.53316200304, 31142.37715245637, 31194.0, 24342.269731908073, 24639.26082217536, 24775.067155310924, 25094.37264068413, 25124.874375628006], "unit": "score", "name": "ext.html", "value": 17105.20805224701}, {"lowerIsBetter": false, "replicates": [350.9105178179565, 358.24946736586855, 361.1188699573042, 367.8951498822836, 371.41131306878594, 15443.768343474843, 15694.372225110996, 16265.99999999997, 16510.83489165108, 16606.50180494584, 16105.516834494954, 16533.66932661346, 16622.0, 16634.334626614953, 16638.0849053302, 4999.600031997432, 5020.849374518752, 5064.620153488485, 5104.33643626328, 5159.071367153911, 5081.237814327844, 5084.974575127119, 5121.5390614844655, 5146.6911985281, 5148.768305426265, 5016.849494515152, 5039.19372900336, 5060.190369540875, 5088.465711100337, 5088.898222035557, 5160.148575485059, 5172.353455818023, 5197.246399272122, 5202.4277329493725, 5206.557442617363, 4968.826091086795, 5001.699898006095, 5003.17447621142, 5006.799728010911, 5008.273800298973, 11596.246243994114, 18817.717734233996, 19345.613087738166, 19421.126049327813, 19444.513887152792, 1802.2520653928605, 1991.2134706790882, 2116.0900812650552, 2241.674957131207, 2390.8804559771943, 9588.328816982814, 11877.762444751057, 11891.881081189164, 12981.286029268387, 13160.934195329059, 1641.5075477356866, 1669.1070277401532, 1761.9868575569099, 1779.813119622434, 1816.8909865407986, 44021.33967990483, 52447.47552524502, 53394.46605533934, 55843.44156558423, 59238.40761592372, 9078.54607269634, 9175.678851240174, 9254.131219322031, 14271.429142834171, 14516.491922782652, 23773.881130594236, 23775.405614859767, 23947.760522394903, 24027.0, 24145.637815432783, 8703.129687031245, 8788.340874434443, 8994.640214391351, 9111.0, 9193.95403022994, 7785.883211751829, 7817.179196184319, 7892.565908875067, 8001.1198768135455, 8036.397270204641, 7771.417143714244, 7778.713984434554, 7886.802829929297, 7901.249381308767, 7909.723159689498, 2913.716836250708, 2947.7347038766616, 3090.459169645303, 3097.4269760094453, 3144.7641426893074, 814.8573999550055, 861.6811779641447, 937.0041810942785, 943.740471370365, 949.1647350331664, 16101.27544260511, 16186.919065404598, 16201.837981620269, 16247.512574622544, 16418.917905410395, 849.1211595998236, 871.54679566625, 880.4761167105562, 887.3211992825494, 965.605298858834, 9038.367314288069, 9313.20837728787, 9463.337566370288, 9524.571394287274, 9583.281253905845, 381801.0, 383561.0, 405627.0, 417817.0, 456082.0, 67391.66304168546, 70017.0, 70320.2967970324, 70458.0, 70520.0, 972.2027937091517, 991.7421470417744, 994.2741798487145, 1003.7390278527636, 1010.1918465227935, 12317.630471085882, 14842.40630374773, 14904.403823847359, 15211.239438027833, 15245.923770381522, 31105.0, 31133.688663113986, 32003.67996320007, 34711.30577388489, 34763.304733904675, 37514.0, 39541.60458395379, 40068.7996560027, 40332.1933561333, 40479.392809107296, 7289.927100728924, 7521.435892308208, 7594.696212151673, 7726.343260822893, 7768.7669369918995, 8509.404341696021, 11659.0, 11702.122340824642, 11713.297202167898, 11799.410029498662, 9827.901720982698, 10163.695089147337, 10290.691279261635, 10382.584696612052, 10585.9470702646, 9830.459324737209, 10232.795344092927, 10261.28171028021, 10310.0, 10412.531436085546, 9657.613695452103, 9833.4099954003, 10155.54300056514, 10259.692209233735, 10731.678049658523, 7106.5736055836815, 7222.313880181585, 7241.203467618663, 7310.96344518274, 7380.667869945973, 7681.961590192013, 9142.268618510636, 10136.391816491034, 10178.08397244222, 10283.588656453658], "unit": "score", "name": "jquery.html", "value": 8461.614741790227}, {"lowerIsBetter": false, "replicates": [1297.5523444411674, 1407.5214427094786, 1432.240912316472, 1592.7929369182004, 1746.685596592613, 6443.774467893625, 7074.9292507074915, 7228.02421673074, 7229.4939354245225, 7234.9276507234845, 7144.642767861612, 7297.854042919152, 7311.963440182805, 7312.488125831194, 7316.231795661445, 1820.1445320699315, 2154.5583155453173, 2202.284257616273, 2219.3785739992745, 2236.955260894781, 2149.387424583994, 2167.9783202167932, 2170.5224850532936, 2173.945651358713, 2174.239016344283, 2078.303768237642, 2167.880766557839, 2174.1738139506965, 2174.4672555223992, 2174.7390313162364, 2029.7868723783938, 2030.7055476955832, 2051.323063389078, 2128.4040468668795, 2134.594427058854, 2119.0993827623197, 2134.1996751218294, 2140.197425965263, 2141.550274442369, 2144.04589957469, 7400.851982960311, 7445.478816482849, 7461.888071678929, 7473.8505229895645, 7485.625718714097, 4432.423784907941, 4577.198990176739, 4587.311903214544, 4596.241620132674, 4601.493835678073, 2868.512352900012, 2912.37383962447, 2956.1574951139037, 2961.511350627144, 2965.8072225305286, 910.3263584947158, 919.0625561926864, 932.5943214701626, 949.539473355422, 952.0812416018506, 10175.287729858914, 10221.591136354537, 10232.69301920936, 10233.539490722935, 10238.283320167591, 4012.1574469361763, 4123.814428350732, 4157.043879907638, 4195.517515485758, 4197.202531519001, 8717.651293948298, 8756.299496040301, 8758.518281494578, 8762.079981601968, 8804.867926980973, 4058.939115913264, 4554.066416384633, 4589.426321709786, 4597.356370108188, 4601.930971035437, 4104.774237416971, 4202.747835129902, 4203.47456567929, 4233.491980962242, 4249.2988656871885, 3452.1714788451095, 3528.770629909048, 3547.5388199534414, 3577.964220357815, 3589.94615080774, 1141.3893566941813, 1168.6902970712767, 1170.052257671272, 1172.935488548121, 1183.6922400175845, 986.980260394788, 1008.7226012846379, 1155.641751057175, 1163.953441862333, 1178.675864137369, 6677.165354330708, 6715.4627629790475, 6719.328067193242, 6721.798346049626, 6730.596164230162, 1113.799516087096, 1117.3631030312645, 1135.9772804543863, 1142.6743378137191, 1157.432857899623, 5460.426655201226, 5497.340319161726, 5522.282103326542, 5533.557315414757, 5534.225208470817, 8299.170082991652, 8934.463932164092, 8956.238719708897, 9060.139286767746, 9065.637374505079, 9051.094890511027, 9086.36395452312, 9090.09099090099, 9124.361294709306, 9153.816923661623, 7007.054047703597, 7091.219965803757, 7210.60341681202, 7220.711171553184, 7263.273672632695, 6735.158105236846, 6751.223609284799, 6772.864542709217, 6779.457643388419, 6786.694598743167, 7895.407844411807, 8272.090070092165, 8280.461769984931, 8294.709685160991, 8337.249647531751, 8304.958475207586, 8473.152684731478, 8588.398812083095, 8611.052784193858, 8616.310695144499, 6202.224721909762, 6211.409916057967, 6466.191726034246, 6469.320721324193, 6475.708593113227, 7039.6832142552685, 7062.223155452999, 7066.57600543969, 7082.61045642474, 7098.893516597358, 6333.714982825876, 6447.677616119082, 6464.450521705708, 6567.2447668518735, 6570.047343135314, 5976.61152025117, 6083.361247069171, 6119.204503414706, 6234.501239900887, 6256.124142619946, 6678.899816502659, 6686.933130668631, 6721.966390168018, 6730.899036514358, 6732.764353247613, 6040.546958978006, 6051.818445446644, 6061.7575296987625, 6132.17215675878, 6160.322364539987, 6207.472364848858, 6211.937880621136, 6245.687715614292, 6256.7810126645345, 6272.780452684134], "unit": "score", "name": "mootools.html", "value": 4275.4412688458615}, {"lowerIsBetter": false, "replicates": [323.65045750589366, 328.5285615142271, 328.6335735654746, 331.5639933487464, 335.9395308844407, 5409.080456322425, 5445.537129344006, 5446.4281250468675, 5470.617056806015, 5496.7526461309235, 5343.251944727732, 5355.598330125236, 5375.731213439322, 5391.757370918308, 5397.62216644834, 3976.5029371328583, 4074.5925407459313, 4132.462779838632, 4175.66594672427, 4191.727537710054, 4161.292580261363, 4176.102138040321, 4198.139381426816, 4205.705600607958, 4210.915781684364, 4166.145940082291, 4173.520045194796, 4175.248455278049, 4181.707280490367, 4192.958070419288, 3953.62440568147, 4111.650509706678, 4154.169166166748, 4156.418101465767, 4173.64524015459, 3655.4151335786146, 3662.7436079474446, 3668.52309199805, 3671.6879065279218, 3676.963230367689, 5140.0, 5143.3313669223135, 5146.099432599281, 5169.948300516984, 5185.585153187736, 4842.249451335048, 4845.636577256684, 4848.0, 4848.466668666444, 4853.320535125085, 5651.717414129277, 5706.9727449059155, 5709.286339207599, 5711.742971566248, 5722.113072473773, 4068.4304197412384, 4072.3077076897, 4073.083556199861, 4075.4701888754566, 4080.2247572961337, 5730.828075157752, 5995.400459954013, 6004.249468816398, 6005.969970150165, 6019.398060193989, 4033.515978082649, 4087.5094988600963, 4088.7137900347284, 4090.734102283342, 4090.9590904091174, 4152.8131234094535, 4155.625993660585, 4158.625723684822, 4159.209750147463, 4161.375793630979, 4779.904401912012, 4785.688930219525, 4786.210275304536, 4787.976060119677, 4788.664793464424, 5712.914306285409, 5734.885302293931, 5736.942630573724, 5738.397468265855, 5740.0, 1436.7126574685105, 1461.2109460891, 1462.2688655672164, 1464.436192066041, 1469.2433396800657, 911.7674992876906, 946.3612061858219, 959.4051687953513, 982.0768477631146, 985.9260555458369, 4921.975390123026, 4957.553820156203, 4960.057589058068, 4968.279599458058, 4976.303317535548, 5834.970825145932, 5870.354261031283, 5883.882322353615, 5888.499477544371, 5889.1755154278435, 4958.305837182797, 4963.70217786934, 4964.751762411865, 4968.378952630921, 4976.62675299354, 3128.3430479599538, 3150.7951983121025, 3157.0371036833985, 3166.95249571252, 3170.920726981844, 5499.175123731472, 5511.338639363222, 5515.889682206333, 5521.641093329001, 5524.254225679562, 5955.196048533479, 6152.600080994721, 6198.0, 6210.968945155245, 6220.25356957159, 5575.330960284792, 5583.134614134816, 5589.720513974285, 5592.3009623796215, 5593.300837395325, 5973.297610181077, 5973.313068997121, 5974.2233509643465, 5986.880262394815, 5988.580799344004, 5866.530677545871, 5872.383399743137, 5877.206577112206, 5878.941210587839, 5885.882282354414, 5386.218998245311, 5557.805476808292, 5559.888802223852, 5568.526675232651, 5570.58220633446, 4025.5169379674626, 4080.897977550585, 4102.876913692594, 4105.0, 4105.835766569304, 5951.047832346804, 5958.791442299499, 5960.8807823844145, 5964.343922168645, 5966.76132954677, 5745.683987380734, 5746.511546518425, 5750.712464376848, 5753.884922301614, 5755.884882302415, 5733.483986441241, 5742.994975879288, 5753.8561535961935, 5759.164921086335, 5759.366469688414, 5433.1035379161995, 5627.0, 5673.06394444912, 5676.176954341515, 5686.459786320293, 5726.0838265877255, 5734.913976290276, 5737.5983681141915, 5776.393478684846, 5777.306723193244, 5635.182898479616, 5637.746301416528, 5643.266375371176, 5652.660840349592, 5654.0], "unit": "score", "name": "prototype.html", "value": 4288.789615908373}, {"lowerIsBetter": false, "replicates": [699.8145491444765, 737.8708725972954, 747.9551226926388, 771.764611793403, 793.7261644732572, 10966.835497467535, 11133.387663678495, 11189.216754827165, 11193.72015699608, 11203.831942520868, 10796.622118225863, 10812.621558245442, 10829.458527073653, 10847.620333288316, 11694.707632309197, 811.0956283743627, 824.7443292579289, 826.099551488877, 826.8181000179981, 827.065416079829, 798.4490701416033, 813.6541969662869, 814.4543156085407, 814.6456291513181, 815.4699445360534, 849.0193826130828, 855.670566831768, 856.1866227084295, 856.6830272799073, 857.0529564830865, 844.9619767110464, 846.4921047371589, 847.656699036891, 849.9362547808909, 851.8509260879383, 624.2197253433209, 625.6652690810395, 625.8466675664446, 625.8560531077832, 626.2078470734524, 11812.586559470463, 11871.406429678482, 11872.52509899603, 11879.940600296943, 11888.454500914826, 12037.819432708517, 12053.93973030138, 12306.692332691664, 12415.193012454161, 12446.937765311206, 9639.132478077006, 9645.42127472354, 9732.805343893153, 9748.561314740853, 9874.259430542737, 3338.599368075822, 3356.4294070007913, 3377.864885404581, 3480.5475288212624, 3481.1993241554333, 43671.78164109159, 43719.344209836876, 43939.0, 44028.55971440276, 44615.77692111551, 9824.410535367759, 9864.210863130933, 9922.702318930444, 10022.699319020441, 10048.748781280381, 17704.911475442797, 17719.73420398695, 17779.73330400045, 17785.46643600694, 17806.55483612894, 6483.805485835433, 6496.740130394731, 6597.274299827015, 6620.106285651375, 6836.077129587442, 3308.6856748608843, 3330.2506935939705, 3360.0927749507496, 3387.2548039431285, 3432.5880894292345, 2785.0, 2820.548712206037, 2820.7038260982713, 2823.858807059639, 2824.632797736281, 496.82996543141104, 502.9270755740397, 515.4175781367031, 516.1122868665889, 516.9379674439091, 491.2017970797454, 592.1059200607115, 606.7239406070228, 623.429561950819, 632.3897438971322, 8062.234087761653, 8249.628766705513, 8331.50010999342, 8335.791605209919, 8550.315974722007, 467.927471241958, 492.8669259299969, 509.48541972607933, 516.5015759791819, 570.3327107284487, 3732.122951106488, 4261.97869010653, 4278.101598664315, 4300.935485967713, 4342.934855977162, 45918.770406148426, 49244.50755492471, 49303.260451093265, 53047.0, 53389.0, 36566.63433365685, 37207.627923720414, 39743.20513589712, 40296.395554066716, 40331.395029074585, 42129.57870421318, 43118.568814312086, 43280.783596082445, 43624.56375436269, 43644.345334820006, 8543.658253669784, 8795.208431241219, 8830.337724670548, 8887.422317549339, 8960.0, 31893.8405307972, 32240.19399515031, 33357.0, 33982.320353593284, 34127.658723412445, 39659.60340396674, 43043.0, 43120.35319470148, 45005.54994450013, 45800.083998320515, 10383.273170877967, 10432.165426765689, 10517.21120915919, 10721.839172412576, 10887.074598658886, 11933.28400295985, 11999.0, 12061.698457538632, 12143.089268304735, 12236.388180591113, 11056.668299951014, 11218.382988935688, 11362.14783891195, 11431.59989400367, 11546.94226528862, 11019.329827168101, 11102.167337449886, 11341.319520828776, 11347.37589432589, 11416.31502109876, 11133.276337038067, 11313.547458101584, 11382.260153090023, 11401.372924489233, 11907.76184476323, 8448.91551084506, 8597.699080532151, 8635.87046194295, 8700.825983480421, 8756.343274254585, 8577.571121444027, 8717.433366831136, 8810.295176386002, 8839.955800220958, 8970.596323165342], "unit": "score", "name": "yui.html", "value": 5888.751959207554}], "name": "dromaeo_css", "value": 6462.982075733466}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 110.0, 114.0, 113.0, 113.0, 101.0, 112.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [164.0, 139.0, 165.0, 182.0, 139.0, 165.0, 166.0, 132.0, 169.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 155.4}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 159.0, 161.0, 162.0, 165.0, 164.0, 160.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [77.0, 74.0, 106.0, 105.0, 73.0, 73.0, 73.0, 116.0, 100.0, 75.0], "unit": "score", "name": "audio-fft", "value": 87.2}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 141.0, 92.0, 94.0, 94.0, 138.0, 93.0, 93.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.6}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 65.0, 64.0, 64.0, 65.0, 65.0, 75.0, 63.0, 62.0], "unit": "score", "name": "json-parse-financial", "value": 65.2}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 64.0, 64.0, 65.0, 64.0, 64.0, 63.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 81.0, 82.0, 83.0, 81.0, 81.0, 83.0, 80.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.8}, {"lowerIsBetter": true, "replicates": [125.0, 127.0, 122.0, 114.0, 112.0, 124.0, 124.0, 114.0, 116.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.3}, {"lowerIsBetter": true, "replicates": [151.0, 142.0, 142.0, 144.0, 140.0, 130.0, 143.0, 142.0, 142.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.9}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 67.0, 66.0, 68.0, 66.0, 68.0, 70.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1520.4}]} 12:23:26 INFO - Return code: 0 12:23:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:23:26 ERROR - # TBPL SUCCESS # 12:23:26 INFO - Running post-action listener: _resource_record_post_action 12:23:26 INFO - Running post-run listener: _resource_record_post_run 12:23:27 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 519995392; Read time: 0; Write time: 424404 12:23:27 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239493120; Read time: 0; Write time: 235700 12:23:27 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 280502272; Read time: 0; Write time: 188704 12:23:27 INFO - Running post-run listener: _upload_blobber_files 12:23:27 INFO - Blob upload gear active. 12:23:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:23:27 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 12:23:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:23:28 INFO - (blobuploader) - INFO - Open directory for files ... 12:23:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:23:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:23:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:29 INFO - (blobuploader) - INFO - Done attempting. 12:23:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:23:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:23:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:30 INFO - (blobuploader) - INFO - Done attempting. 12:23:30 INFO - (blobuploader) - INFO - Iteration through files over. 12:23:30 INFO - Return code: 0 12:23:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:23:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:23:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82b6def1ef7d4e8363a967e0056cd820f9d3da469a4443c0d7babd102cc8bca0f31ca581908e9548aa4a4a39a28703924d0da7c0483e57642121a87e294dcecd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/439fae358198bc6bcb990efc5aea8203f8eebed00ceb751917f4c00162f73705147393925776ad0b452b20b98eb2b0c0098c332f6caf5e51eff3d55acc507357"} 12:23:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:23:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:23:30 INFO - Contents: 12:23:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82b6def1ef7d4e8363a967e0056cd820f9d3da469a4443c0d7babd102cc8bca0f31ca581908e9548aa4a4a39a28703924d0da7c0483e57642121a87e294dcecd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/439fae358198bc6bcb990efc5aea8203f8eebed00ceb751917f4c00162f73705147393925776ad0b452b20b98eb2b0c0098c332f6caf5e51eff3d55acc507357"} 12:23:30 INFO - Running post-run listener: copy_logs_to_upload_dir 12:23:30 INFO - Copying logs to upload dir... 12:23:30 INFO - mkdir: /builds/slave/test/build/upload/logs 12:23:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.862665 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-04-02 12:23:29.420111) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-02 12:23:29.423718) ========= 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=ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/82b6def1ef7d4e8363a967e0056cd820f9d3da469a4443c0d7babd102cc8bca0f31ca581908e9548aa4a4a39a28703924d0da7c0483e57642121a87e294dcecd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/439fae358198bc6bcb990efc5aea8203f8eebed00ceb751917f4c00162f73705147393925776ad0b452b20b98eb2b0c0098c332f6caf5e51eff3d55acc507357"} build_url:https://queue.taskcluster.net/v1/task/d5a6-XkRRpmNI2lkcD077A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/d5a6-XkRRpmNI2lkcD077A/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/Firefox-Non-PGO/sha512/82b6def1ef7d4e8363a967e0056cd820f9d3da469a4443c0d7babd102cc8bca0f31ca581908e9548aa4a4a39a28703924d0da7c0483e57642121a87e294dcecd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/439fae358198bc6bcb990efc5aea8203f8eebed00ceb751917f4c00162f73705147393925776ad0b452b20b98eb2b0c0098c332f6caf5e51eff3d55acc507357"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-02 12:23:29.449094) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:23:29.449460) ========= 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=ed14279e38b05397cf4aa391000001a4-1459616341.995463-1753717887 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-02 12:23:29.538152) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-02 12:23:29.538945) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-02 12:23:29.539629) ========= ========= Total master_lag: 2.48 =========