builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1460562373.37 results: success (0) buildid: 20160413025454 builduid: 92a52cbcfb084946925fc427cda60a3b revision: 564b225d553547fe4aa9a1039278f695c9507db9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:13.373079) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:13.373647) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:13.373967) ========= 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=52faae308a556c440401f8e5000001e8-1460560865.392701-623076491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006369 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:13.397273) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:13.397548) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:13.410424) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:13.410689) ========= 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=52faae308a556c440401f8e5000001e8-1460560865.392701-623076491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:13.459819) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:13.460086) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:13.460467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:13.460743) ========= 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=52faae308a556c440401f8e5000001e8-1460560865.392701-623076491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 08:46:15-- 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% 32.2M=0s 2016-04-13 08:46:15 (32.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092508 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:13.565502) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:13.565795) ========= 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=52faae308a556c440401f8e5000001e8-1460560865.392701-623076491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023169 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:13.614693) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:13.615015) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 564b225d553547fe4aa9a1039278f695c9507db9 --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 564b225d553547fe4aa9a1039278f695c9507db9 --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=52faae308a556c440401f8e5000001e8-1460560865.392701-623076491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 08:46:15,424 truncating revision to first 12 chars 2016-04-13 08:46:15,424 Setting DEBUG logging. 2016-04-13 08:46:15,424 attempt 1/10 2016-04-13 08:46:15,424 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/564b225d5535?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 08:46:15,669 unpacking tar archive at: mozilla-central-564b225d5535/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532613 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:14.160186) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:14.160524) ========= echo 564b225d553547fe4aa9a1039278f695c9507db9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'564b225d553547fe4aa9a1039278f695c9507db9'] 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=52faae308a556c440401f8e5000001e8-1460560865.392701-623076491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 564b225d553547fe4aa9a1039278f695c9507db9 program finished with exit code 0 elapsedTime=0.004064 script_repo_revision: '564b225d553547fe4aa9a1039278f695c9507db9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:14.209903) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:14.210209) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 08:46:14.220047) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-13 08:46:14.220342) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=52faae308a556c440401f8e5000001e8-1460560865.392701-623076491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:46:16 INFO - MultiFileLogger online at 20160413 08:46:16 in /builds/slave/test 08:46:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 08:46:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:46:16 INFO - {'append_to_log': False, 08:46:16 INFO - 'base_work_dir': '/builds/slave/test', 08:46:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:46:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:46:16 INFO - 'branch': 'Firefox-Non-PGO', 08:46:16 INFO - 'buildbot_json_path': 'buildprops.json', 08:46:16 INFO - 'config_files': ('talos/linux_config.py',), 08:46:16 INFO - 'default_actions': ('clobber', 08:46:16 INFO - 'read-buildbot-config', 08:46:16 INFO - 'download-and-extract', 08:46:16 INFO - 'populate-webroot', 08:46:16 INFO - 'create-virtualenv', 08:46:16 INFO - 'install', 08:46:16 INFO - 'run-tests'), 08:46:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:46:16 INFO - 'download_minidump_stackwalk': True, 08:46:16 INFO - 'download_symbols': 'ondemand', 08:46:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:46:16 INFO - 'tooltool.py': '/tools/tooltool.py', 08:46:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:46:16 INFO - '/tools/misc-python/virtualenv.py')}, 08:46:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:46:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:46:16 INFO - 'installer_path': 'installer.exe', 08:46:16 INFO - 'log_level': 'info', 08:46:16 INFO - 'log_name': 'talos', 08:46:16 INFO - 'log_to_console': True, 08:46:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:46:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:46:16 INFO - 'opt_config_files': (), 08:46:16 INFO - 'pip_index': False, 08:46:16 INFO - 'sps_profile': False, 08:46:16 INFO - 'sps_profile_interval': 0, 08:46:16 INFO - 'suite': 'dromaeojs-e10s', 08:46:16 INFO - 'system_bits': '32', 08:46:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:46:16 INFO - 'title': 'talos-linux64-ix-056', 08:46:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:46:16 INFO - 'use_talos_json': True, 08:46:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:46:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:46:16 INFO - 'work_dir': 'build'} 08:46:16 INFO - ##### 08:46:16 INFO - ##### Running clobber step. 08:46:16 INFO - ##### 08:46:16 INFO - Running pre-action listener: _resource_record_pre_action 08:46:16 INFO - Running main action method: clobber 08:46:16 INFO - rmtree: /builds/slave/test/build 08:46:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:46:16 INFO - Running post-action listener: _resource_record_post_action 08:46:16 INFO - ##### 08:46:16 INFO - ##### Running read-buildbot-config step. 08:46:16 INFO - ##### 08:46:16 INFO - Running pre-action listener: _resource_record_pre_action 08:46:16 INFO - Running main action method: read_buildbot_config 08:46:16 INFO - Using buildbot properties: 08:46:16 INFO - { 08:46:16 INFO - "project": "", 08:46:16 INFO - "product": "firefox", 08:46:16 INFO - "script_repo_revision": "production", 08:46:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:46:16 INFO - "repository": "", 08:46:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:46:16 INFO - "buildid": "20160413025454", 08:46:16 INFO - "pgo_build": "False", 08:46:16 INFO - "basedir": "/builds/slave/test", 08:46:16 INFO - "buildnumber": 286, 08:46:16 INFO - "slavename": "talos-linux64-ix-056", 08:46:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:46:16 INFO - "platform": "ubuntu64_hw", 08:46:16 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:46:16 INFO - "branch": "mozilla-central", 08:46:16 INFO - "repo_path": "mozilla-central", 08:46:16 INFO - "revision": "564b225d553547fe4aa9a1039278f695c9507db9", 08:46:16 INFO - "stage_platform": "linux64", 08:46:16 INFO - "builduid": "92a52cbcfb084946925fc427cda60a3b", 08:46:16 INFO - "slavebuilddir": "test" 08:46:16 INFO - } 08:46:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:46:16 INFO - Running post-action listener: _resource_record_post_action 08:46:16 INFO - ##### 08:46:16 INFO - ##### Running download-and-extract step. 08:46:16 INFO - ##### 08:46:16 INFO - Running pre-action listener: _resource_record_pre_action 08:46:16 INFO - Running main action method: download_and_extract 08:46:16 INFO - mkdir: /builds/slave/test/build/tests 08:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:16 INFO - https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:46:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:46:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:46:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/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 08:46:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/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 08:46:24 INFO - Downloaded 1361 bytes. 08:46:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:46:24 INFO - Using the following test package requirements: 08:46:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:46:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:46:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:24 INFO - u'jsshell-linux-x86_64.zip'], 08:46:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:46:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:46:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:46:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:46:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:46:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:46: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')]} 08:46:24 INFO - https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:46:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:46:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:46:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/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 08:46:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/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 08:46:37 INFO - Downloaded 22198810 bytes. 08:46:37 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'] 08:46:37 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 08:46:38 INFO - Return code: 0 08:46:38 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 08:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:38 INFO - https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:46:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:46:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:46:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/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 08:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/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 08:46:39 INFO - Downloaded 22198810 bytes. 08:46:39 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'] 08:46:39 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 08:46:40 INFO - Return code: 0 08:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:40 INFO - https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:46:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:46:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:46:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/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 08:46:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/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 08:46:42 INFO - Downloaded 10841076 bytes. 08:46:42 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'] 08:46:42 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 08:46:42 INFO - Return code: 0 08:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:42 INFO - https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:46:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:46:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:46:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/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 08:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/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 08:46:43 INFO - Downloaded 54152078 bytes. 08:46:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:46:43 INFO - mkdir: /builds/slave/test/properties 08:46:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:46:43 INFO - Writing to file /builds/slave/test/properties/build_url 08:46:43 INFO - Contents: 08:46:43 INFO - build_url:https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:46:44 INFO - Running post-action listener: _resource_record_post_action 08:46:44 INFO - Running post-action listener: set_extra_try_arguments 08:46:44 INFO - ##### 08:46:44 INFO - ##### Running populate-webroot step. 08:46:44 INFO - ##### 08:46:44 INFO - Running pre-action listener: _resource_record_pre_action 08:46:44 INFO - Running main action method: populate_webroot 08:46:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:46:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:46:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:46:44 INFO - '--tppagecycles', 08:46:44 INFO - '7'], 08:46:44 INFO - 'tests': ['tsvgm']}}, 08:46:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:46:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:46:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:46:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:46:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:46:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:46:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:44 INFO - 'talos_options': ['--disable-e10s'], 08:46:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:44 INFO - 'talos_options': ['--disable-e10s'], 08:46:44 INFO - 'tests': ['damp', 'tps']}, 08:46:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:44 INFO - 'tests': ['damp', 'tps']}, 08:46:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:46:44 INFO - 'tests': ['dromaeo_dom']}, 08:46:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:46:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:46:44 INFO - 'tests': ['a11yr', 08:46:44 INFO - 'ts_paint', 08:46:44 INFO - 'tpaint', 08:46:44 INFO - 'sessionrestore', 08:46:44 INFO - 'sessionrestore_no_auto_restore', 08:46:44 INFO - 'tabpaint']}, 08:46:44 INFO - 'other-e10s': {'tests': ['a11yr', 08:46:44 INFO - 'ts_paint', 08:46:44 INFO - 'tpaint', 08:46:44 INFO - 'sessionrestore', 08:46:44 INFO - 'sessionrestore_no_auto_restore', 08:46:44 INFO - 'tabpaint']}, 08:46:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:46:44 INFO - 'ts_paint', 08:46:44 INFO - 'tpaint', 08:46:44 INFO - 'sessionrestore', 08:46:44 INFO - 'sessionrestore_no_auto_restore', 08:46:44 INFO - 'tabpaint']}, 08:46:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:46:44 INFO - 'ts_paint', 08:46:44 INFO - 'tpaint', 08:46:44 INFO - 'sessionrestore', 08:46:44 INFO - 'sessionrestore_no_auto_restore', 08:46:44 INFO - 'tabpaint']}, 08:46:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:46:44 INFO - 'tests': ['a11yr', 08:46:44 INFO - 'ts_paint', 08:46:44 INFO - 'tpaint', 08:46:44 INFO - 'sessionrestore', 08:46:44 INFO - 'sessionrestore_no_auto_restore', 08:46:44 INFO - 'tabpaint']}, 08:46:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:46:44 INFO - 'tests': ['a11yr', 08:46:44 INFO - 'ts_paint', 08:46:44 INFO - 'tpaint', 08:46:44 INFO - 'sessionrestore', 08:46:44 INFO - 'sessionrestore_no_auto_restore', 08:46:44 INFO - 'tabpaint']}, 08:46:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:46:44 INFO - 'tests': ['tsvgx', 08:46:44 INFO - 'tsvgr_opacity', 08:46:44 INFO - 'tart', 08:46:44 INFO - 'tscrollx', 08:46:44 INFO - 'cart']}, 08:46:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:46:44 INFO - 'tsvgr_opacity', 08:46:44 INFO - 'tart', 08:46:44 INFO - 'tscrollx', 08:46:44 INFO - 'cart']}, 08:46:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:44 INFO - 'talos_options': ['--disable-e10s'], 08:46:44 INFO - 'tests': ['tp5o']}, 08:46:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:44 INFO - 'tests': ['tp5o']}, 08:46:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:44 INFO - 'talos_options': ['--disable-e10s', 08:46:44 INFO - '--xperf_path', 08:46:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:44 INFO - 'tests': ['tp5n']}, 08:46:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:44 INFO - 'talos_options': ['--xperf_path', 08:46:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:44 INFO - 'tests': ['tp5n']}}, 08:46:44 INFO - 'talos.zip': {'path': '', 08:46:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:46:44 INFO - Running post-action listener: _resource_record_post_action 08:46:44 INFO - ##### 08:46:44 INFO - ##### Running create-virtualenv step. 08:46:44 INFO - ##### 08:46:44 INFO - Running pre-action listener: _resource_record_pre_action 08:46:44 INFO - Running main action method: create_virtualenv 08:46:44 INFO - Creating virtualenv /builds/slave/test/build/venv 08:46:44 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 08:46:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:46:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:46:44 INFO - Using real prefix '/usr' 08:46:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:46:45 INFO - Installing distribute.............................................................................................................................................................................................done. 08:46:47 INFO - Installing pip.................done. 08:46:47 INFO - Return code: 0 08:46:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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')]} 08:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:47 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 0x7f3c58d36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb410>, '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 0x17cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc7a0>, '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': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', '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 08:46:47 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 08:46:47 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 08:46:47 INFO - Using env: {'DISPLAY': ':0', 08:46:47 INFO - 'HOME': '/home/cltbld', 08:46:47 INFO - 'LANG': 'en_US.UTF-8', 08:46:47 INFO - 'LANGUAGE': 'en_US:en', 08:46:47 INFO - 'LOGNAME': 'cltbld', 08:46:47 INFO - 'MAIL': '/var/mail/cltbld', 08:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:47 INFO - 'MOZ_NO_REMOTE': '1', 08:46:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:47 INFO - 'NO_EM_RESTART': '1', 08:46:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:47 INFO - 'PWD': '/builds/slave/test', 08:46:47 INFO - 'SHELL': '/bin/bash', 08:46:47 INFO - 'SHLVL': '1', 08:46:47 INFO - 'TERM': 'linux', 08:46:47 INFO - 'TMOUT': '86400', 08:46:47 INFO - 'USER': 'cltbld', 08:46:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', 08:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:47 INFO - '_': '/tools/buildbot/bin/python'} 08:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:47 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 08:46:47 INFO - Cleaning up... 08:46:47 INFO - Return code: 0 08:46:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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')]} 08:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:47 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 0x7f3c58d36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb410>, '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 0x17cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc7a0>, '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': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', '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 08:46:47 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 08:46:47 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 08:46:47 INFO - Using env: {'DISPLAY': ':0', 08:46:47 INFO - 'HOME': '/home/cltbld', 08:46:47 INFO - 'LANG': 'en_US.UTF-8', 08:46:47 INFO - 'LANGUAGE': 'en_US:en', 08:46:47 INFO - 'LOGNAME': 'cltbld', 08:46:47 INFO - 'MAIL': '/var/mail/cltbld', 08:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:47 INFO - 'MOZ_NO_REMOTE': '1', 08:46:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:47 INFO - 'NO_EM_RESTART': '1', 08:46:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:47 INFO - 'PWD': '/builds/slave/test', 08:46:47 INFO - 'SHELL': '/bin/bash', 08:46:47 INFO - 'SHLVL': '1', 08:46:47 INFO - 'TERM': 'linux', 08:46:47 INFO - 'TMOUT': '86400', 08:46:47 INFO - 'USER': 'cltbld', 08:46:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', 08:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:47 INFO - '_': '/tools/buildbot/bin/python'} 08:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:47 INFO - Downloading/unpacking psutil>=0.7.1 08:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:46:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:49 INFO - Installing collected packages: psutil 08:46:49 INFO - Running setup.py install for psutil 08:46:49 INFO - building 'psutil._psutil_linux' extension 08:46:49 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 08:46:49 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 08:46:49 INFO - building 'psutil._psutil_posix' extension 08:46:49 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 08:46:49 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 08:46:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:50 INFO - Successfully installed psutil 08:46:50 INFO - Cleaning up... 08:46:50 INFO - Return code: 0 08:46:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3c58d36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb410>, '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 0x17cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc7a0>, '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': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', '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 08:46:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:46:50 INFO - Using env: {'DISPLAY': ':0', 08:46:50 INFO - 'HOME': '/home/cltbld', 08:46:50 INFO - 'LANG': 'en_US.UTF-8', 08:46:50 INFO - 'LANGUAGE': 'en_US:en', 08:46:50 INFO - 'LOGNAME': 'cltbld', 08:46:50 INFO - 'MAIL': '/var/mail/cltbld', 08:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:50 INFO - 'MOZ_NO_REMOTE': '1', 08:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:50 INFO - 'NO_EM_RESTART': '1', 08:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:50 INFO - 'PWD': '/builds/slave/test', 08:46:50 INFO - 'SHELL': '/bin/bash', 08:46:50 INFO - 'SHLVL': '1', 08:46:50 INFO - 'TERM': 'linux', 08:46:50 INFO - 'TMOUT': '86400', 08:46:50 INFO - 'USER': 'cltbld', 08:46:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', 08:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:50 INFO - '_': '/tools/buildbot/bin/python'} 08:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:46:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:46:52 INFO - Installing collected packages: mozsystemmonitor 08:46:52 INFO - Running setup.py install for mozsystemmonitor 08:46:52 INFO - Successfully installed mozsystemmonitor 08:46:52 INFO - Cleaning up... 08:46:52 INFO - Return code: 0 08:46:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:46:52 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')]} 08:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:52 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')]} 08:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:52 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 0x7f3c58d36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb410>, '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 0x17cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc7a0>, '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': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', '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 08:46:52 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 08:46:52 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 08:46:52 INFO - Using env: {'DISPLAY': ':0', 08:46:52 INFO - 'HOME': '/home/cltbld', 08:46:52 INFO - 'LANG': 'en_US.UTF-8', 08:46:52 INFO - 'LANGUAGE': 'en_US:en', 08:46:52 INFO - 'LOGNAME': 'cltbld', 08:46:52 INFO - 'MAIL': '/var/mail/cltbld', 08:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:52 INFO - 'MOZ_NO_REMOTE': '1', 08:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:52 INFO - 'NO_EM_RESTART': '1', 08:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:52 INFO - 'PWD': '/builds/slave/test', 08:46:52 INFO - 'SHELL': '/bin/bash', 08:46:52 INFO - 'SHLVL': '1', 08:46:52 INFO - 'TERM': 'linux', 08:46:52 INFO - 'TMOUT': '86400', 08:46:52 INFO - 'USER': 'cltbld', 08:46:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', 08:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:52 INFO - '_': '/tools/buildbot/bin/python'} 08:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:52 INFO - Downloading/unpacking blobuploader==1.2.4 08:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:54 INFO - Downloading blobuploader-1.2.4.tar.gz 08:46:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:46:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:46:54 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 08:46:54 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 08:46:54 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 08:46:54 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 08:46:54 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 08:46:54 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 08:46:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:46:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:55 INFO - Downloading docopt-0.6.1.tar.gz 08:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:46:55 INFO - Installing collected packages: blobuploader, requests, docopt 08:46:55 INFO - Running setup.py install for blobuploader 08:46:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:46:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:46:55 INFO - Running setup.py install for requests 08:46:55 INFO - Running setup.py install for docopt 08:46:55 INFO - Successfully installed blobuploader requests docopt 08:46:55 INFO - Cleaning up... 08:46:55 INFO - Return code: 0 08:46:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:55 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')]} 08:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:55 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')]} 08:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:55 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 0x7f3c58d36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb410>, '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 0x17cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc7a0>, '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': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', '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 08:46:55 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 08:46:55 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 08:46:55 INFO - Using env: {'DISPLAY': ':0', 08:46:55 INFO - 'HOME': '/home/cltbld', 08:46:55 INFO - 'LANG': 'en_US.UTF-8', 08:46:55 INFO - 'LANGUAGE': 'en_US:en', 08:46:55 INFO - 'LOGNAME': 'cltbld', 08:46:55 INFO - 'MAIL': '/var/mail/cltbld', 08:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:55 INFO - 'MOZ_NO_REMOTE': '1', 08:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:55 INFO - 'NO_EM_RESTART': '1', 08:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:55 INFO - 'PWD': '/builds/slave/test', 08:46:55 INFO - 'SHELL': '/bin/bash', 08:46:55 INFO - 'SHLVL': '1', 08:46:55 INFO - 'TERM': 'linux', 08:46:55 INFO - 'TMOUT': '86400', 08:46:55 INFO - 'USER': 'cltbld', 08:46:55 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', 08:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:55 INFO - '_': '/tools/buildbot/bin/python'} 08:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:56 INFO - Running setup.py (path:/tmp/pip-fO3fvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:56 INFO - Running setup.py (path:/tmp/pip-_nyyLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:56 INFO - Running setup.py (path:/tmp/pip-9fwhph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:56 INFO - Running setup.py (path:/tmp/pip-s_O5mT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:56 INFO - Running setup.py (path:/tmp/pip-PvLuJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:56 INFO - Running setup.py (path:/tmp/pip-mRi5J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:56 INFO - Running setup.py (path:/tmp/pip-ncJkOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:56 INFO - Running setup.py (path:/tmp/pip-R00XqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:56 INFO - Running setup.py (path:/tmp/pip-lb1LtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:56 INFO - Running setup.py (path:/tmp/pip-Io8z4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:56 INFO - Running setup.py (path:/tmp/pip-GYPrxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:56 INFO - Running setup.py (path:/tmp/pip-7t0mSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:57 INFO - Running setup.py (path:/tmp/pip-FsUKv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:57 INFO - Running setup.py (path:/tmp/pip-WCn8kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:57 INFO - Running setup.py (path:/tmp/pip-aY7XzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:57 INFO - Running setup.py (path:/tmp/pip-dmhcJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:57 INFO - Running setup.py (path:/tmp/pip-MMLjsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:46:57 INFO - Running setup.py install for manifestparser 08:46:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:46:57 INFO - Running setup.py install for mozcrash 08:46:57 INFO - Running setup.py install for mozdebug 08:46:57 INFO - Running setup.py install for mozdevice 08:46:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:46:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:46:57 INFO - Running setup.py install for mozfile 08:46:57 INFO - Running setup.py install for mozhttpd 08:46:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for mozinfo 08:46:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for mozInstall 08:46:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for mozleak 08:46:58 INFO - Running setup.py install for mozlog 08:46:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for moznetwork 08:46:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for mozprocess 08:46:58 INFO - Running setup.py install for mozprofile 08:46:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for mozrunner 08:46:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:46:58 INFO - Running setup.py install for mozscreenshot 08:46:58 INFO - Running setup.py install for moztest 08:46:59 INFO - Running setup.py install for mozversion 08:46:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:46:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:46:59 INFO - Cleaning up... 08:46:59 INFO - Return code: 0 08:46:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:59 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')]} 08:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:59 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')]} 08:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:59 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 0x7f3c58d36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb410>, '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 0x17cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc7a0>, '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': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', '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 08:46:59 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 08:46:59 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 08:46:59 INFO - Using env: {'DISPLAY': ':0', 08:46:59 INFO - 'HOME': '/home/cltbld', 08:46:59 INFO - 'LANG': 'en_US.UTF-8', 08:46:59 INFO - 'LANGUAGE': 'en_US:en', 08:46:59 INFO - 'LOGNAME': 'cltbld', 08:46:59 INFO - 'MAIL': '/var/mail/cltbld', 08:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:59 INFO - 'MOZ_NO_REMOTE': '1', 08:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:59 INFO - 'NO_EM_RESTART': '1', 08:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:59 INFO - 'PWD': '/builds/slave/test', 08:46:59 INFO - 'SHELL': '/bin/bash', 08:46:59 INFO - 'SHLVL': '1', 08:46:59 INFO - 'TERM': 'linux', 08:46:59 INFO - 'TMOUT': '86400', 08:46:59 INFO - 'USER': 'cltbld', 08:46:59 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', 08:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:59 INFO - '_': '/tools/buildbot/bin/python'} 08:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:59 INFO - Running setup.py (path:/tmp/pip-F2Zfje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:59 INFO - Running setup.py (path:/tmp/pip-rO4HbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:59 INFO - Running setup.py (path:/tmp/pip-cFI4_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:59 INFO - Running setup.py (path:/tmp/pip-O6dfSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:59 INFO - Running setup.py (path:/tmp/pip-jOfg8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:59 INFO - Running setup.py (path:/tmp/pip-bZc5kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:59 INFO - Running setup.py (path:/tmp/pip-E6tiHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:59 INFO - Running setup.py (path:/tmp/pip-ggSRHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:59 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)) 08:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:00 INFO - Running setup.py (path:/tmp/pip-2WaFYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:00 INFO - Running setup.py (path:/tmp/pip-OTPCbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:00 INFO - Running setup.py (path:/tmp/pip-YE5qFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:00 INFO - Running setup.py (path:/tmp/pip-iqRV2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:00 INFO - Running setup.py (path:/tmp/pip-FPBMJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:00 INFO - Running setup.py (path:/tmp/pip-wUw9ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:00 INFO - Running setup.py (path:/tmp/pip-bZ7zcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:00 INFO - Running setup.py (path:/tmp/pip-RF5oON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:00 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)) 08:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:00 INFO - Running setup.py (path:/tmp/pip-UFX_TI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:00 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)) 08:47:00 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)) 08:47:00 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)) 08:47:00 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)) 08:47:00 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)) 08:47:00 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)) 08:47:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:47:00 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 08:47:00 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 08:47:00 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 08:47:00 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 08:47:00 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 08:47:00 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 08:47:02 INFO - Downloading blessings-1.6.tar.gz 08:47:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:47:02 INFO - Installing collected packages: blessings 08:47:02 INFO - Running setup.py install for blessings 08:47:02 INFO - Successfully installed blessings 08:47:02 INFO - Cleaning up... 08:47:02 INFO - Return code: 0 08:47:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:47:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:02 INFO - Reading from file tmpfile_stdout 08:47:02 INFO - Current package versions: 08:47:02 INFO - argparse == 1.2.1 08:47:02 INFO - blessings == 1.6 08:47:02 INFO - blobuploader == 1.2.4 08:47:02 INFO - docopt == 0.6.1 08:47:02 INFO - manifestparser == 1.1 08:47:02 INFO - mozInstall == 1.12 08:47:02 INFO - mozcrash == 0.17 08:47:02 INFO - mozdebug == 0.1 08:47:02 INFO - mozdevice == 0.48 08:47:02 INFO - mozfile == 1.2 08:47:02 INFO - mozhttpd == 0.7 08:47:02 INFO - mozinfo == 0.9 08:47:02 INFO - mozleak == 0.1 08:47:02 INFO - mozlog == 3.1 08:47:02 INFO - moznetwork == 0.27 08:47:02 INFO - mozprocess == 0.22 08:47:02 INFO - mozprofile == 0.28 08:47:02 INFO - mozrunner == 6.11 08:47:02 INFO - mozscreenshot == 0.1 08:47:02 INFO - mozsystemmonitor == 0.0 08:47:02 INFO - moztest == 0.7 08:47:02 INFO - mozversion == 1.4 08:47:02 INFO - psutil == 3.1.1 08:47:02 INFO - requests == 1.2.3 08:47:02 INFO - wsgiref == 0.1.2 08:47:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:02 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')]} 08:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:02 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')]} 08:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:02 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 0x7f3c58d36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb410>, '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 0x17cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc7a0>, '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': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', '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 08:47:02 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 08:47:02 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 08:47:02 INFO - Using env: {'DISPLAY': ':0', 08:47:02 INFO - 'HOME': '/home/cltbld', 08:47:02 INFO - 'LANG': 'en_US.UTF-8', 08:47:02 INFO - 'LANGUAGE': 'en_US:en', 08:47:02 INFO - 'LOGNAME': 'cltbld', 08:47:02 INFO - 'MAIL': '/var/mail/cltbld', 08:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:02 INFO - 'MOZ_NO_REMOTE': '1', 08:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:02 INFO - 'NO_EM_RESTART': '1', 08:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:02 INFO - 'PWD': '/builds/slave/test', 08:47:02 INFO - 'SHELL': '/bin/bash', 08:47:02 INFO - 'SHLVL': '1', 08:47:02 INFO - 'TERM': 'linux', 08:47:02 INFO - 'TMOUT': '86400', 08:47:02 INFO - 'USER': 'cltbld', 08:47:02 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', 08:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:02 INFO - '_': '/tools/buildbot/bin/python'} 08:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:03 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)) 08:47:03 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)) 08:47:03 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)) 08:47:03 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)) 08:47:03 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)) 08:47:03 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)) 08:47:03 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)) 08:47:03 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)) 08:47:03 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)) 08:47:03 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)) 08:47:03 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)) 08:47:03 INFO - Cleaning up... 08:47:03 INFO - Return code: 0 08:47:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c58d36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb410>, '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 0x17cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc7a0>, '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': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', '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 08:47:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:47:03 INFO - Using env: {'DISPLAY': ':0', 08:47:03 INFO - 'HOME': '/home/cltbld', 08:47:03 INFO - 'LANG': 'en_US.UTF-8', 08:47:03 INFO - 'LANGUAGE': 'en_US:en', 08:47:03 INFO - 'LOGNAME': 'cltbld', 08:47:03 INFO - 'MAIL': '/var/mail/cltbld', 08:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:03 INFO - 'MOZ_NO_REMOTE': '1', 08:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:03 INFO - 'NO_EM_RESTART': '1', 08:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:03 INFO - 'PWD': '/builds/slave/test', 08:47:03 INFO - 'SHELL': '/bin/bash', 08:47:03 INFO - 'SHLVL': '1', 08:47:03 INFO - 'TERM': 'linux', 08:47:03 INFO - 'TMOUT': '86400', 08:47:03 INFO - 'USER': 'cltbld', 08:47:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', 08:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:03 INFO - '_': '/tools/buildbot/bin/python'} 08:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:03 INFO - Downloading/unpacking jsonschema 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:47:05 INFO - Downloading/unpacking functools32 (from jsonschema) 08:47:05 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 08:47:05 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 08:47:05 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 08:47:05 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 08:47:05 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 08:47:05 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 08:47:05 INFO - Downloading functools32-3.2.3-2.tar.gz 08:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:47:05 INFO - warning: no files found matching '*.txt' 08:47:05 INFO - no previously-included directories found matching 'build' 08:47:05 INFO - no previously-included directories found matching 'dist' 08:47:05 INFO - no previously-included directories found matching '.git*' 08:47:05 INFO - Installing collected packages: jsonschema, functools32 08:47:05 INFO - Running setup.py install for functools32 08:47:05 INFO - warning: no files found matching '*.txt' 08:47:05 INFO - no previously-included directories found matching 'build' 08:47:05 INFO - no previously-included directories found matching 'dist' 08:47:05 INFO - no previously-included directories found matching '.git*' 08:47:05 INFO - Successfully installed jsonschema functools32 08:47:05 INFO - Cleaning up... 08:47:05 INFO - Return code: 0 08:47:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:47:05 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')]} 08:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:05 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')]} 08:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:05 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 0x7f3c58d36f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x173c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17cb410>, '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 0x17cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc7a0>, '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': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', '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 08:47:05 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 08:47:05 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 08:47:05 INFO - Using env: {'DISPLAY': ':0', 08:47:05 INFO - 'HOME': '/home/cltbld', 08:47:05 INFO - 'LANG': 'en_US.UTF-8', 08:47:05 INFO - 'LANGUAGE': 'en_US:en', 08:47:05 INFO - 'LOGNAME': 'cltbld', 08:47:05 INFO - 'MAIL': '/var/mail/cltbld', 08:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:05 INFO - 'MOZ_NO_REMOTE': '1', 08:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:05 INFO - 'NO_EM_RESTART': '1', 08:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:05 INFO - 'PWD': '/builds/slave/test', 08:47:05 INFO - 'SHELL': '/bin/bash', 08:47:05 INFO - 'SHLVL': '1', 08:47:05 INFO - 'TERM': 'linux', 08:47:05 INFO - 'TMOUT': '86400', 08:47:05 INFO - 'USER': 'cltbld', 08:47:05 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', 08:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:05 INFO - '_': '/tools/buildbot/bin/python'} 08:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:05 INFO - Downloading/unpacking flake8 08:47:05 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 08:47:05 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 08:47:05 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 08:47:05 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 08:47:05 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 08:47:05 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 08:47:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:47:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:47:07 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 08:47:07 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 08:47:07 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 08:47:07 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 08:47:07 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 08:47:07 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 08:47:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:47:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:47:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:47:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:47:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:47:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:47:08 INFO - no previously-included directories found matching 'docs/_build' 08:47:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:47:08 INFO - Running setup.py install for pep8 08:47:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:47:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:47:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:47:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:47:08 INFO - no previously-included directories found matching 'docs/_build' 08:47:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:47:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:47:08 INFO - Cleaning up... 08:47:08 INFO - Return code: 0 08:47:08 INFO - Running post-action listener: _resource_record_post_action 08:47:08 INFO - Running post-action listener: _start_resource_monitoring 08:47:08 INFO - Starting resource monitoring. 08:47:08 INFO - ##### 08:47:08 INFO - ##### Running install step. 08:47:08 INFO - ##### 08:47:08 INFO - Running pre-action listener: _resource_record_pre_action 08:47:08 INFO - Running main action method: install 08:47:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:09 INFO - Reading from file tmpfile_stdout 08:47:09 INFO - Detecting whether we're running mozinstall >=1.0... 08:47:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:47:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:47:09 INFO - Reading from file tmpfile_stdout 08:47:09 INFO - Output received: 08:47:09 INFO - Usage: mozinstall [options] installer 08:47:09 INFO - Options: 08:47:09 INFO - -h, --help show this help message and exit 08:47:09 INFO - -d DEST, --destination=DEST 08:47:09 INFO - Directory to install application into. [default: 08:47:09 INFO - "/builds/slave/test"] 08:47:09 INFO - --app=APP Application being installed. [default: firefox] 08:47:09 INFO - mkdir: /builds/slave/test/build/application 08:47:09 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'] 08:47:09 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 08:47:24 INFO - Reading from file tmpfile_stdout 08:47:24 INFO - Output received: 08:47:24 INFO - /builds/slave/test/build/application/firefox/firefox 08:47:24 INFO - Running post-action listener: _resource_record_post_action 08:47:24 INFO - ##### 08:47:24 INFO - ##### Running run-tests step. 08:47:24 INFO - ##### 08:47:24 INFO - Running pre-action listener: _resource_record_pre_action 08:47:24 INFO - Running main action method: run_tests 08:47:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:47:24 INFO - Python 2.7.3 08:47:24 INFO - Return code: 0 08:47:24 INFO - grabbing minidump binary from tooltool 08:47: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')]} 08:47:24 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 0x17cb410>, '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 0x17cc310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17cc7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:47:24 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 08:47:24 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 08:47:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:47:24 INFO - Return code: 0 08:47:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:47:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:47:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:47:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:47:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:47:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:47:25 INFO - Return code: 0 08:47:25 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:47:25 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:47:25 INFO - Using env: {'DISPLAY': ':0', 08:47:25 INFO - 'HOME': '/home/cltbld', 08:47:25 INFO - 'LANG': 'en_US.UTF-8', 08:47:25 INFO - 'LANGUAGE': 'en_US:en', 08:47:25 INFO - 'LOGNAME': 'cltbld', 08:47:25 INFO - 'MAIL': '/var/mail/cltbld', 08:47:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:47:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:25 INFO - 'MOZ_NO_REMOTE': '1', 08:47:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:25 INFO - 'NO_EM_RESTART': '1', 08:47:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:25 INFO - 'PWD': '/builds/slave/test', 08:47:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:47:25 INFO - 'SHELL': '/bin/bash', 08:47:25 INFO - 'SHLVL': '1', 08:47:25 INFO - 'TERM': 'linux', 08:47:25 INFO - 'TMOUT': '86400', 08:47:25 INFO - 'USER': 'cltbld', 08:47:25 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460560865.392701-623076491', 08:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:25 INFO - '_': '/tools/buildbot/bin/python'} 08:47:25 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:47:26 INFO - mozversion application_buildid: 20160413025454 08:47:26 INFO - mozversion application_changeset: 564b225d553547fe4aa9a1039278f695c9507db9 08:47:26 INFO - mozversion application_display_name: Nightly 08:47:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:47:26 INFO - mozversion application_name: Firefox 08:47:26 INFO - mozversion application_remotingname: firefox 08:47:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:47:26 INFO - mozversion application_vendor: Mozilla 08:47:26 INFO - mozversion application_version: 48.0a1 08:47:26 INFO - mozversion platform_buildid: 20160413025454 08:47:26 INFO - mozversion platform_changeset: 564b225d553547fe4aa9a1039278f695c9507db9 08:47:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:47:26 INFO - mozversion platform_version: 48.0a1 08:47:26 INFO - using testdate: 1460562446 08:47:26 INFO - actual date: 1460562446 08:47:26 INFO - starting webserver on 'localhost:52306' 08:47:26 INFO - SUITE-START | Running 2 tests 08:47:26 INFO - TEST-START | dromaeo_css 08:47:26 INFO - operating with platform_type : linux_ 08:47:26 INFO - Initialising browser for dromaeo_css test... 08:47:26 INFO - TEST-INFO | started process 18138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoBeL77/profile http://localhost:52306/getInfo.html) 08:47:30 INFO - PROCESS | 18138 | 08:47:30 INFO - PROCESS | 18138 | (process:18207): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:47:30 INFO - PROCESS | 18138 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:47:31 INFO - PROCESS | 18138 | __metrics Screen width/height:1600/1200 08:47:31 INFO - PROCESS | 18138 | colorDepth:24 08:47:31 INFO - PROCESS | 18138 | Browser inner width/height: 1024/697 08:47:31 INFO - PROCESS | 18138 | __metrics 08:47:32 ERROR - PROCESS | 18138 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:47:33 INFO - TEST-INFO | 18138: exit 0 08:47:33 INFO - Browser initialized. 08:47:33 INFO - Running cycle 1/1 for dromaeo_css test... 08:47:33 INFO - TEST-INFO | started process 18258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoBeL77/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:35 INFO - PROCESS | 18258 | 08:47:35 INFO - PROCESS | 18258 | (process:18318): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:47:45 INFO - PROCESS | 18258 | RSS: Main: 164417536 08:47:45 INFO - PROCESS | 18258 | 08:48:35 INFO - PROCESS | 18258 | 1460562514999 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] 08:50:46 INFO - PROCESS | 18258 | Cycle 1(1): loaded http://localhost:52306/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52306/tests/dromaeo/cssquery-ext.html) 08:50:47 INFO - PROCESS | 18258 | RSS: Main: 169574400 08:50:47 INFO - PROCESS | 18258 | 08:53:49 INFO - PROCESS | 18258 | Cycle 1(1): loaded http://localhost:52306/tests/dromaeo/cssquery-ext.html (next: http://localhost:52306/tests/dromaeo/cssquery-jquery.html) 08:53:50 INFO - PROCESS | 18258 | RSS: Main: 164909056 08:53:50 INFO - PROCESS | 18258 | 08:56:52 INFO - PROCESS | 18258 | Cycle 1(1): loaded http://localhost:52306/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52306/tests/dromaeo/cssquery-mootools.html) 08:56:52 INFO - PROCESS | 18258 | RSS: Main: 166137856 08:56:52 INFO - PROCESS | 18258 | 08:59:54 INFO - PROCESS | 18258 | Cycle 1(1): loaded http://localhost:52306/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52306/tests/dromaeo/cssquery-prototype.html) 08:59:55 INFO - PROCESS | 18258 | RSS: Main: 163770368 08:59:55 INFO - PROCESS | 18258 | 09:02:57 INFO - PROCESS | 18258 | Cycle 1(1): loaded http://localhost:52306/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52306/tests/dromaeo/cssquery-yui.html) 09:02:58 INFO - PROCESS | 18258 | RSS: Main: 165122048 09:02:58 INFO - PROCESS | 18258 | 09:06:01 INFO - PROCESS | 18258 | Cycle 1(1): loaded http://localhost:52306/tests/dromaeo/cssquery-yui.html (next: http://localhost:52306/tests/dromaeo/cssquery-dojo.html) 09:06:01 INFO - PROCESS | 18258 | RSS: Main: 166744064 09:06:01 INFO - PROCESS | 18258 | 09:06:01 INFO - PROCESS | 18258 | __start_tp_report 09:06:01 INFO - PROCESS | 18258 | _x_x_mozilla_page_load 09:06:01 INFO - PROCESS | 18258 | _x_x_mozilla_page_load_details 09:06:01 INFO - PROCESS | 18258 | |i|pagename|runs| 09:06:01 INFO - PROCESS | 18258 | |0;dojo.html;2604.6353510508525;2651.70831208567;2674.6790385153786;2685.1944416675005;2695.4070104577;4687.953120468795;4702.506236845129;4726.810927562898;4786.09064277787;4846.030793841237;4638.837640682568;4652.418447694038;4679.766011699418;4692.882677933053;4704.294355846625;4240.936385954213;4307.483102027745;4353.825846966118;4358.3244597087505;4368.62866656333;4267.850625228118;4269.573042695721;4301.978490107545;4331.45856767904;4399.714018588797;4225.767582782945;4241.448611680462;4269.210196113729;4287.335463003239;4297.527272000078;4269.7224680395675;4284.250256205183;4288.378185163134;4325.199838029975;4338.848140315105;4146.3780432935;4278.251306021434;4285.421468101828;4316.417283666696;4322.7190232634775;4558.111168322179;4622.237330840408;4622.6070783983405;4676.228422310314;4677.532246775329;5078.949210507884;5106.361704786902;5112.079825631385;5114.28400023997;5126.256692779563;4937.851864444036;5043.067032598944;5110.3356563646485;5117.974410127963;5167.767450464738;4728.692634978715;4749.121412538622;4753.144434001843;4756.619470442356;4799.808007679723;5177.948220517746;5178.663386879841;5181.481851814789;5199.766010529535;5227.869303267449;4786.377770889762;4938.654294199371;4976.850694479172;4981.476944920803;5026.246063090565;4895.975520122377;4991.151504244287;5019.945811379578;5078.873028174326;5113.463086375877;4943.307936888838;4955.876103097451;4963.875903102379;4985.750712464363;5011.799528018912;4837.467878533358;4933.28467372229;4940.061388336277;4996;5029.421616514148;3870.729048966545;3877.747946383476;3882.7087968402484;3902.687784977195;3912.7456715313415;3453.930921381558;3455.7926524408617;3471.7569770116356;3478.5999610044664;3496.230829217568;4283.357496375506;4357.3899654048455;4413.668974826901;4435.379046933432;4459.509453960127;5059.924101138486;5077.289179514871;5085.4914508548845;5103.770330335144;5107.055194788976;4432.069265454226;4435.977820110943;4438.533953934855;4440.666949978765;4445.466544014739;4395.604395604411;4476.4180656514445;4502.729836209838;4514.774261286988;4538.52345503724;4786.856394308176;4800.567948884617;4809.110314591811;4827.493113223061;4828.589569886599;5022.1964485683575;5031.471695471922;5048.141815891381;5069.721165335942;5102.1326374515675;4831.227003679394;4859.878503037311;4863.148948933993;4870.561649451566;4897.069556784199;4946.208606622923;4959.380077490314;4973.6269779765935;4980.203167493184;5014.548690617862;4926.433460152129;5033.144365457808;5051.838077242328;5080.669756465818;5086.821961231339;4836.443808962014;4879.512048795092;4955.752212389438;4995.575376093073;5009.649324547247;4887.853364399074;4906.55840974314;4908.239222920453;4909.189983652657;4921.778519966539;4775.498572649822;4804.927926081042;4818.10864989978;4849.030193961293;4859.416869975626;4878.829240976691;5002.599792016703;5023.146065168857;5033.766727151871;5073.365829271341;4831.347768051409;4844.975775121102;4851.854444366674;4860.9513904861915;4898.3142360068905 09:06:01 INFO - PROCESS | 18258 | |1;ext.html;584.8596336879148;603.4538742438094;606.9848253793657;624.750099960016;641.3682522715122;33646.327073458546;34790.304193916105;34843;34931.82534087326;35038.29923401531;37209;38054.8097259514;38138.42792358117;38147.23705525895;38210.235795284076;7601.543907365548;7873.094594121663;7875.684972601089;7878.212178782133;7878.25156610124;7705.576193309365;7858.960705196495;7873.645685944118;8063.193680631948;8075.475094118863;8007.51954882706;8008.27925486706;8055.113937466874;8059.314958228558;8092.514449133041;7998.200179982014;8019.278264956153;8027.678892844308;8039.07550631679;8080.151584083704;7768.7669369918995;7847.9215207847765;7881.842363152705;8014.599270036533;8056;37584;38476;38494.615053849666;38597.614023859685;38738.22523549541;2571.691397032368;3005.549167624852;3021.6222972128485;3083.1367217179227;3089.7373723233554;24750.876245618656;25186.11848585309;25548.872255638787;26066.478670426484;28937.710622893712;3434.1929646533044;3438.673326034023;3440.776349537272;3520.9088277280193;3536.664016918389;210251;211069;211252;211387;211904.99999999846;53070.20394694083;53198.73400632972;53260;53381.466185338424;53426.46573534293;56775;58336.4166358331;59931;60130;60720;13791.310434478237;13909.095908765898;14067.929660351632;14074.366653500618;14111.15333079998;10643.574257029632;10776.515056822462;10847.620333288454;10902.618408355669;10920;17817.287308507774;17964.730529042074;18619.534511637048;18651.533711657317;18790.53023674419;6798.66006699663;6836.350546698056;6875.243723190445;7102.360787529147;7109.8933515997305;787.52354825331;825.6037102190862;827.995860020708;851.5997481183833;912.6623149434752;27025.729742702322;27502.587461188097;27639.86180069087;27797.861010694818;27820.86089569539;959.822432849925;981.2738573455734;996.3772642098688;1046.3617193511952;1047.4134484688445;14366.209858457885;14476.767131773635;14561.635959101108;14650.853491465163;14704.632384190267;361326;368018;368843;369482;373560;50030;50457;50541;50551.24173137406;50555.49444505582;1238.294172321786;1265.8101284807353;1281.5002149161835;1282;1369.2469141971876;25414.364640884127;26349;26953.800625855773;27296.863515682293;27440.725592744617;42394.1521169581;42967;43089.56910430855;43137;43286;302399;307642;308132;308570;309410;25596.488070238862;25621.87189064043;25774.613380798928;25779.871100644377;25812.09657661973;43159.78420107879;43364.78317608392;43487.347689784045;43830.780846095564;44116.55883441253;36812.21441212625;37436.06409839776;37498.625013749515;37824.43263350997;38121.23757524778;37009.62990370062;37043;37049;37110.8144459276;37473.250534988605;29884.551731723608;32667.673323267412;33916;34444;35313.1171720709;30201.825324630026;31345.686543134278;32286.35427291488;35753.64246357607;37152.81423592865;23072.192473263356;23115.768842312034;23225.419364516023;23239.535209296057;23350 09:06:01 INFO - PROCESS | 18258 | |2;jquery.html;373.68610367291467;386.8876978686275;389.0875896023825;389.6279053503904;407.92249472600224;15448;17302.394416195435;17918.104094795257;18041.909790451064;18072.096395180237;16067.357305707787;16907.74638380422;16974.49076527706;17173.82826171738;17212.31150753968;5031.572316353115;5170.3795544534705;5197.766100525467;5213.843584692465;5225.085610018251;3686.2627474505207;5554.444555544434;5885.617434866741;5896.204012458306;5904.202932604107;5670.829875103754;5855.180274761537;5855.8536036599;5882.14708867214;5903.439173278532;5839.124131380285;5854.88290234195;5876.676782776945;5889.7644094236175;5891.351951285355;4609.262517997138;4946.109700253989;5139.614528910347;5162.096633089194;5185.222216667492;11667.883321166764;11728.237664551862;11792.174547781658;11865.762684746343;11901.33381326615;2007.4278830533228;2012.5974805038904;2014.9294774682962;2033.044469099521;2042.7548694156649;9070.092990700878;9077.682281120195;9179.127982841619;9367.156955874005;9417.717468475958;1701.7277235642239;1724.913754312292;1732.610162713392;1758.1824451630052;1777.4489908128392;69706;69805.30194698038;70652.646736766;71128;71187.64406177988;10055.346402483816;10098.848517272247;10153.746156346151;10158.593656253666;10275.897241027644;14336.713265734836;14468.493602723855;14507.564773056825;14555.41778328855;14555.78166327506;7109.466789990772;7185.497015208885;7269.709211631475;7338.669759860819;7354.448416368794;6563.409293163638;6603.603783772989;6614.6361950093205;6675.499337549606;6764.5603035802515;4363.5418281080665;4386.736795792199;4401.801918913657;4420.9336859947125;4509.932351014738;1700.3708627807544;1770.7963584187983;1878.5773201029933;1904.228787341129;1916.2335065973723;413.2334519466407;828.3083625173048;877.1535468273147;878.2183856367838;889.4129874283071;9594.760130996781;9952.15406690425;9953.900460995297;10056.994300569884;10076.29465937392;410.36188726529934;412.3381971935061;417.7180403227809;418.4016855896037;419.28511887232196;5336.386315573681;5412.675239485643;5415.268938693304;5427.158790387496;5578.442155784389;309212;426346;432342;432738;445904;81543;83043;83663;83990;84588.57705711432;429.6992105526207;433.37810242302396;437.98905027373934;439.4353256066004;441.66433510531584;9259.76850578741;9438.38650487716;9710.417374957526;9740.172085372822;9760.365576237522;30990.535141973338;31369;32295.838520807247;34051.829740851135;34260.82869585636;40847.1830563393;41163;41195;41414.58585414107;41433;7304.160021597584;7332.156801967629;7345.192028876926;7481.2144724805285;7675.5010924289745;8621.913780862362;10896.891031089905;11026.944865275622;11109.833352499558;11635.243709158878;9314.068593140631;9405.106514881076;9500.334976551576;9504.95247523758;9547.283953703361;9428.528573571431;9478.146966773023;9663.565139568596;9730.464824434725;9936.453495057553;8495.702650407206;9629.470379129216;9711.36876103051;9807.166390856857;10010.349327293703;6451.41937225652;6797.252302246848;7216.458765592706;7780.961095194488;7806.258405451473;9226.308026897876;9318.860217096613;9415;9581.90418095838;9746.85379719319 09:06:01 INFO - PROCESS | 18258 | |3;mootools.html;1479.3638735343802;1492.3218596779413;1651.9504414867558;1773.0514174916423;1779.0393187678653;6909.378155965962;7571.4321425893;7593.430492713055;7863.528188308698;7891.053073631165;7613.771586852389;7673.654685539164;7679.616019199046;7721.03487064117;7721.266479684435;2270.6821045053707;2299.1378233162563;2299.9195028174017;2300.056976639578;2312.063614236237;2201.0755482697227;2209.69064330993;2263.7509873913937;2268.6483595042796;2270.114655284432;2269.682244485765;2271.761465046163;2272.3864556569715;2282.463621049052;2297.8161747060194;2194.572058448603;2196.5716685246384;2204.9779502205092;2213.8339624528144;2215.7784221577795;2156.277646988261;2160.4274867160216;2164.1559791681257;2188.2997440818945;2189.5620875824898;7837.529748215068;7912.248336408032;7969.481983671043;7986.161453047463;8069.757907262791;4606.516315786861;4734.668573199878;4740.478547359788;4791.496892826272;4794.808207671724;2933.1200639808185;3077.815331080142;3196.392685389792;3203.2312245061253;3235.6117265928006;966.7244835221928;1016.1565900302732;1020.7346090016575;1021.3310281765456;1036.6164519127894;10599.523021464052;10600.310979786289;10618;10658.094062004739;10694.786104277871;4035.899102522402;4223.260929337353;4328.199283132568;4363.712704752105;4412.073464572476;9231.261499080192;9238.907610923805;9265.44407335562;9322.394044387092;9342.626294948126;4582.725036497821;4591.1965406053805;4614.192516309632;4630.513796051366;4631.235846085426;3690.9630903691154;4281.272183728774;4300.075483770942;4323.978380108079;4434.911301774011;3618.751530721897;3693.1505753676806;3747.3816820224356;3795.8291876865605;3851.807409629507;1236.5919246648764;1241.5902752091788;1242.8260043593905;1244.0296568676447;1257.6289994451658;861.1388611388611;876.6756300168978;876.8860048193694;878.0297770962994;879.8680197970356;5596.58025648078;5624.29696287964;5642.435756424325;5670.489655930904;5808.477237048686;927.2859897878595;974.6491263145263;994.1202036198017;997.6432052408718;1016.1870503597092;3529.4705794130573;3730.5523337199165;3811.866584669523;3824.7896365700153;3829.9808500957874;9578;9909.801803963881;9960.750981225527;9960.950195248977;10048.296619236584;8537.658493660185;8950.418222815497;9814.656487023063;9819.901800982041;9869.802603947881;7285.307895749896;7298.087739032621;7320.487565870338;7425.071866016748;7450.180480147288;5153.587712983027;5409.188621706776;5463.180522921593;5520.309961254843;5581.888362232814;8289.751307460785;8547.102554231717;8702.869456958277;8903.955480222558;9001.414908030956;8925.910740892508;8976;9199.310051746012;9330.673426430043;9361.251099911855;6290.119383286252;6820.488463365168;7036.437085033287;7073.540219885691;7180.3537681608905;7581.886271705818;7620.504667196615;7633.2366763323225;7634.236576342321;7683.769486915401;6604.801855944329;6971.372576468142;6998.300169982961;7038.190608080136;7045.788626341218;6815.454763618998;6826.419754320938;6844.384005439534;6890.345417185359;6939.930600693929;6508.544401891822;6516.413522782783;6592.406683398517;6628.07206991012;6651.102101216467;4757.858114052671;4785.9042819144115;4806.134895718804;4854.393200849894;4866.80532778699;4832.734199619054;4833.226683730586;4836.564709176191;4838.975805120952;4852.781624826821 09:06:01 INFO - PROCESS | 18258 | |4;prototype.html;316.9619645642523;319.43778949049664;327.1151535097561;328.6270083455279;328.9539464474974;5232.633715639907;5234.241035049916;5265.236540701596;5284.867878303035;5295.788168473261;5226.132661830246;5230.764615592298;5242.292290540776;5265.921011184835;5270.4729527047375;3853.2486165197797;3947.605239476058;4086.509618845743;4088.4889388826396;4108.753474791507;4093.9181216375655;4100.343944968806;4101.610347017028;4105.876823695279;4119.134981653856;4075.1442197138635;4076.714629975888;4078.3270760324513;4084.97957510212;4085.6935729820384;3757.9436308455397;4002.7198096133284;4012.6589239914642;4070.470838790953;4076.8381011411752;3470.3059388122224;3504.0539054455407;3507.632023510833;3516.859325626972;3520.6303338149637;4935.333729946447;4950.777215025332;4963.975180124076;4967;4978.377702787152;4398.119231903109;4611.4005179326805;4651.116287905287;4651.790669419885;4674;5518.392976772552;5530.142827861688;5540.2243685884005;5545;5557.972210138963;3854.209886973164;3871.2257548490416;3876.2828876657627;3891.8637847675477;3904.824282907276;5634.380013293797;5719.941810765022;5722.227499287626;5751.712414379264;5804.129380592903;3812.5234345706785;3906.0430194602504;3910.354791459434;3930.8231129598666;3936.4488971544006;3912.628300311466;3916.5691773904846;3931.1154990126993;3934.8229329680235;3937.6062393760394;4604.8388306409115;4607.493175750665;4611.746353950565;4621.168189725881;4631.907361852744;5211.739413029409;5525.419830917776;5529.087700529368;5543.77824887;5546.55627549795;1394.0868730981224;1397.7559971625262;1405.9947137796526;1409.9647508812361;1412.4067891485602;857.5497863621524;929.8326301265702;939.3189937295542;961.6345788600287;962.4273557233435;4816.590589799836;4838.685485443435;4847.515248475124;4851.708897466164;4854.247591623304;5568.331800184003;5614.242077319591;5615.382307946123;5641.266635337462;5643.125315576092;4576.88557786058;4778.1638213312535;4779.354787103696;4789.688670236424;4792.412097467329;2986.0743169617053;2998.970010299869;3010.5935698680837;3031.439183751013;3034.787564870438;5301.575873930076;5326.733663316819;5330.760115794798;5355.651882627694;5367.329083864517;5585.128981791064;5686.886262274814;5723.484886360247;5729.762684083479;5788.88422231553;5261;5276.34045744282;5287.629865909426;5301.416844147141;5308.840734777963;5408.729563521887;5615.606907516435;5626.915596265977;5627.465390787868;5628.268325117709;5461.781528738965;5496.862578435571;5518.724063796874;5524.502794748492;5531.7234138292115;5195.454477279831;5282.788688452419;5286.81496147633;5324.600654950972;5326.866828329323;3779.6787273082095;3985.143194213258;3987.1626958339075;3987.521497420328;4001.7999100045463;5693.544516438592;5711.114777209373;5723.856903577277;5725.456081672234;5728.598998070095;5434.989054050026;5456;5466.3713672928125;5516.972415138059;5535.197396377584;5339.7597108131;5501.909274475834;5511.614187006871;5513.58648101386;5525.226468294361;5204.739763011758;5420.13277875538;5424.24060631504;5435.728213589384;5454.890902182014;5394.460553944574;5563.499285064364;5566.77732890696;5603.35561410443;5606.018946684396;5427.402985671494;5438.184272359178;5442.455754424526;5451.073317535949;5455.563554915518 09:06:01 INFO - PROCESS | 18258 | |5;yui.html;693.4313862632644;748.5471289869629;768.2356055724554;778.3034184404958;808.8503626829041;11931.343776092312;12207.816882746754;12295.446704898279;12420.192687475319;12427.937860310685;12170.208936419127;12230.694232644188;12611.684707882285;12643.49426022958;12687;660.709287913319;812.1513018895268;819.9057108432518;828.225609055535;831.4387788242911;833.7790485521342;835.9582020898961;838.6729175621513;838.7567605394428;839.588601585225;872.7861673889906;875.5797217335651;876.8860048193726;877.1272583779148;878.5914549734372;863.6718047142109;865.2040123086775;870.5908223135116;873.4890089297705;875.2866413872705;640.4940097323109;644.2655372874926;646.447287569131;647.1522305779444;647.9805605831832;13095.541656042087;13148.342582870819;13230.470781168742;13243.072984891061;13303.534376296782;12749.490020399266;12855.733625471466;13074.607761767162;13133.212007279593;13305.869001134915;10232.43721595312;10360.218520240134;10416.114630256438;10431.269811113225;10442.843357349646;3334.1164591383304;3361.344537815127;3386.1703882548686;3407.693307602328;3421.0421082097055;42487.150256994995;45237;45494.09011819745;45579.77210113928;45600.08799823985;9496.762580935394;10063;10063.798724025624;10127.949360253151;10182.694519164437;16640.417585384454;16653.750193747102;16671.749923751155;16698.332066717194;16761.580960476087;6957.026016357714;7015.649217539205;7038.6480675965995;7048.330408611174;7314.96342518284;3976.264391087658;3988.6011398860464;4035.233305671913;4086.3257562501853;4102.630763231324;2803.71962803718;2859.628248327704;2871.9856400717863;2872.1527149490535;2880.683124856264;532.8747744280091;552.6324993879106;557.5985290590768;573.3607028163651;607.5959486941223;555.7610227602089;643.5302229372584;650.6551527690332;663.3830537599982;664.0934283452041;7817.140114587391;7817.413693972975;8041.959790201012;8496.70261540843;8515.57422128891;546.336201515153;549.7608540284989;553.3885057011944;557.637535601862;559.9580031497654;3857.556381016163;3989.9800500997308;4063.8187753802595;4090.284200264942;4090.5091389033505;58057;59619.70190149022;60090.19729408125;60137;60202.096968545506;50906;51977;52430.213546796826;52481.2127818083;52678.473215268124;46223.53776462192;46811.5318846814;47644.28533571999;48294.758526207144;48462;7689.923100769144;7786.221377862168;7851.568163751049;7943.563104029334;7994.2805147537;30983.535246970863;31261;31335.529967050057;31505.369892602477;32057.67942320547;32517;34853;38852;40910.386344204264;42849;10606.628767993083;10933.671989840317;10969.474335682498;10988.395638239974;11160.944195279297;11990.520379184734;12016.939915300718;12098.516059357527;12374.566890159162;12720.363981801058;11079.72300692489;11406.657800266004;11435.256708313933;11656.650300491;11983.400829958642;10791;10841.482192493215;10867.51096200657;11128.554857805597;11356.318620882774;10711.464426778786;10870.402127883042;11256.380899050631;11382.715432114263;11452.14108941816;9101.817963640822;9171.954140229256;9439.244860411289;9710.271729620166;9966.252531060345;9603;9610.66362677303;9636;9815.803683926424;9889.554970026222 09:06:01 INFO - PROCESS | 18258 | __end_tp_report 09:06:01 INFO - PROCESS | 18258 | __start_cc_report 09:06:01 INFO - PROCESS | 18258 | _x_x_mozilla_cycle_collect,379 09:06:01 INFO - PROCESS | 18258 | __end_cc_report 09:06:01 INFO - PROCESS | 18258 | __startTimestamp1460563561290__endTimestamp 09:06:01 INFO - PROCESS | 18258 | 09:06:01 INFO - PROCESS | 18258 | ------- Summary: start ------- 09:06:01 INFO - PROCESS | 18258 | Number of tests: 6 09:06:01 INFO - PROCESS | 18258 | 09:06:01 INFO - PROCESS | 18258 | [#0] dojo.html Cycles:165 Average:4643.40 Median:4828.59 stddev:520.94 (10.8%) stddev-sans-first:497.38 09:06:01 INFO - PROCESS | 18258 | Values: 2604.6 2651.7 2674.7 2685.2 2695.4 4688.0 4702.5 4726.8 4786.1 4846.0 4638.8 4652.4 4679.8 4692.9 4704.3 4240.9 4307.5 4353.8 4358.3 4368.6 4267.9 4269.6 4302.0 4331.5 4399.7 4225.8 4241.4 4269.2 4287.3 4297.5 4269.7 4284.3 4288.4 4325.2 4338.8 4146.4 4278.3 4285.4 4316.4 4322.7 4558.1 4622.2 4622.6 4676.2 4677.5 5078.9 5106.4 5112.1 5114.3 5126.3 4937.9 5043.1 5110.3 5118.0 5167.8 4728.7 4749.1 4753.1 4756.6 4799.8 5177.9 5178.7 5181.5 5199.8 5227.9 4786.4 4938.7 4976.9 4981.5 5026.2 4896.0 4991.2 5019.9 5078.9 5113.5 4943.3 4955.9 4963.9 4985.8 5011.8 4837.5 4933.3 4940.1 4996.0 5029.4 3870.7 3877.7 3882.7 3902.7 3912.7 3453.9 3455.8 3471.8 3478.6 3496.2 4283.4 4357.4 4413.7 4435.4 4459.5 5059.9 5077.3 5085.5 5103.8 5107.1 4432.1 4436.0 4438.5 4440.7 4445.5 4395.6 4476.4 4502.7 4514.8 4538.5 4786.9 4800.6 4809.1 4827.5 4828.6 5022.2 5031.5 5048.1 5069.7 5102.1 4831.2 4859.9 4863.1 4870.6 4897.1 4946.2 4959.4 4973.6 4980.2 5014.5 4926.4 5033.1 5051.8 5080.7 5086.8 4836.4 4879.5 4955.8 4995.6 5009.6 4887.9 4906.6 4908.2 4909.2 4921.8 4775.5 4804.9 4818.1 4849.0 4859.4 4878.8 5002.6 5023.1 5033.8 5073.4 4831.3 4845.0 4851.9 4861.0 4898.3 09:06:01 INFO - PROCESS | 18258 | 09:06:01 INFO - PROCESS | 18258 | [#1] ext.html Cycles:180 Average:45338.30 Median:203245.81 stddev:79625.56 (39.2%) stddev-sans-first:79778.03 09:06:01 INFO - PROCESS | 18258 | Values: 584.9 603.5 607.0 624.8 641.4 33646.3 34790.3 34843.0 34931.8 35038.3 37209.0 38054.8 38138.4 38147.2 38210.2 7601.5 7873.1 7875.7 7878.2 7878.3 7705.6 7859.0 7873.6 8063.2 8075.5 8007.5 8008.3 8055.1 8059.3 8092.5 7998.2 8019.3 8027.7 8039.1 8080.2 7768.8 7847.9 7881.8 8014.6 8056.0 37584.0 38476.0 38494.6 38597.6 38738.2 2571.7 3005.5 3021.6 3083.1 3089.7 24750.9 25186.1 25548.9 26066.5 28937.7 3434.2 3438.7 3440.8 3520.9 3536.7 210251.0 211069.0 211252.0 211387.0 211905.0 53070.2 53198.7 53260.0 53381.5 53426.5 56775.0 58336.4 59931.0 60130.0 60720.0 13791.3 13909.1 14067.9 14074.4 14111.2 10643.6 10776.5 10847.6 10902.6 10920.0 17817.3 17964.7 18619.5 18651.5 18790.5 6798.7 6836.4 6875.2 7102.4 7109.9 787.5 825.6 828.0 851.6 912.7 27025.7 27502.6 27639.9 27797.9 27820.9 959.8 981.3 996.4 1046.4 1047.4 14366.2 14476.8 14561.6 14650.9 14704.6 361326.0 368018.0 368843.0 369482.0 373560.0 50030.0 50457.0 50541.0 50551.2 50555.5 1238.3 1265.8 1281.5 1282.0 1369.2 25414.4 26349.0 26953.8 27296.9 27440.7 42394.2 42967.0 43089.6 43137.0 43286.0 302399.0 307642.0 308132.0 308570.0 309410.0 25596.5 25621.9 25774.6 25779.9 25812.1 43159.8 43364.8 43487.3 43830.8 44116.6 36812.2 37436.1 37498.6 37824.4 38121.2 37009.6 37043.0 37049.0 37110.8 37473.3 29884.6 32667.7 33916.0 34444.0 35313.1 30201.8 31345.7 32286.4 35753.6 37152.8 23072.2 23115.8 23225.4 23239.5 23350.0 09:06:01 INFO - PROCESS | 18258 | 09:06:01 INFO - PROCESS | 18258 | [#2] jquery.html Cycles:180 Average:23843.48 Median:5191.49 stddev:68197.69 (1313.6%) stddev-sans-first:68366.23 09:06:01 INFO - PROCESS | 18258 | Values: 373.7 386.9 389.1 389.6 407.9 15448.0 17302.4 17918.1 18041.9 18072.1 16067.4 16907.7 16974.5 17173.8 17212.3 5031.6 5170.4 5197.8 5213.8 5225.1 3686.3 5554.4 5885.6 5896.2 5904.2 5670.8 5855.2 5855.9 5882.1 5903.4 5839.1 5854.9 5876.7 5889.8 5891.4 4609.3 4946.1 5139.6 5162.1 5185.2 11667.9 11728.2 11792.2 11865.8 11901.3 2007.4 2012.6 2014.9 2033.0 2042.8 9070.1 9077.7 9179.1 9367.2 9417.7 1701.7 1724.9 1732.6 1758.2 1777.4 69706.0 69805.3 70652.6 71128.0 71187.6 10055.3 10098.8 10153.7 10158.6 10275.9 14336.7 14468.5 14507.6 14555.4 14555.8 7109.5 7185.5 7269.7 7338.7 7354.4 6563.4 6603.6 6614.6 6675.5 6764.6 4363.5 4386.7 4401.8 4420.9 4509.9 1700.4 1770.8 1878.6 1904.2 1916.2 413.2 828.3 877.2 878.2 889.4 9594.8 9952.2 9953.9 10057.0 10076.3 410.4 412.3 417.7 418.4 419.3 5336.4 5412.7 5415.3 5427.2 5578.4 309212.0 426346.0 432342.0 432738.0 445904.0 81543.0 83043.0 83663.0 83990.0 84588.6 429.7 433.4 438.0 439.4 441.7 9259.8 9438.4 9710.4 9740.2 9760.4 30990.5 31369.0 32295.8 34051.8 34260.8 40847.2 41163.0 41195.0 41414.6 41433.0 7304.2 7332.2 7345.2 7481.2 7675.5 8621.9 10896.9 11026.9 11109.8 11635.2 9314.1 9405.1 9500.3 9505.0 9547.3 9428.5 9478.1 9663.6 9730.5 9936.5 8495.7 9629.5 9711.4 9807.2 10010.3 6451.4 6797.3 7216.5 7781.0 7806.3 9226.3 9318.9 9415.0 9581.9 9746.9 09:06:01 INFO - PROCESS | 18258 | 09:06:01 INFO - PROCESS | 18258 | [#3] mootools.html Cycles:180 Average:5239.57 Median:5010.20 stddev:2858.92 (57.1%) stddev-sans-first:2852.97 09:06:01 INFO - PROCESS | 18258 | Values: 1479.4 1492.3 1652.0 1773.1 1779.0 6909.4 7571.4 7593.4 7863.5 7891.1 7613.8 7673.7 7679.6 7721.0 7721.3 2270.7 2299.1 2299.9 2300.1 2312.1 2201.1 2209.7 2263.8 2268.6 2270.1 2269.7 2271.8 2272.4 2282.5 2297.8 2194.6 2196.6 2205.0 2213.8 2215.8 2156.3 2160.4 2164.2 2188.3 2189.6 7837.5 7912.2 7969.5 7986.2 8069.8 4606.5 4734.7 4740.5 4791.5 4794.8 2933.1 3077.8 3196.4 3203.2 3235.6 966.7 1016.2 1020.7 1021.3 1036.6 10599.5 10600.3 10618.0 10658.1 10694.8 4035.9 4223.3 4328.2 4363.7 4412.1 9231.3 9238.9 9265.4 9322.4 9342.6 4582.7 4591.2 4614.2 4630.5 4631.2 3691.0 4281.3 4300.1 4324.0 4434.9 3618.8 3693.2 3747.4 3795.8 3851.8 1236.6 1241.6 1242.8 1244.0 1257.6 861.1 876.7 876.9 878.0 879.9 5596.6 5624.3 5642.4 5670.5 5808.5 927.3 974.6 994.1 997.6 1016.2 3529.5 3730.6 3811.9 3824.8 3830.0 9578.0 9909.8 9960.8 9961.0 10048.3 8537.7 8950.4 9814.7 9819.9 9869.8 7285.3 7298.1 7320.5 7425.1 7450.2 5153.6 5409.2 5463.2 5520.3 5581.9 8289.8 8547.1 8702.9 8904.0 9001.4 8925.9 8976.0 9199.3 9330.7 9361.3 6290.1 6820.5 7036.4 7073.5 7180.4 7581.9 7620.5 7633.2 7634.2 7683.8 6604.8 6971.4 6998.3 7038.2 7045.8 6815.5 6826.4 6844.4 6890.3 6939.9 6508.5 6516.4 6592.4 6628.1 6651.1 4757.9 4785.9 4806.1 4854.4 4866.8 4832.7 4833.2 4836.6 4839.0 4852.8 09:06:01 INFO - PROCESS | 18258 | 09:06:01 INFO - PROCESS | 18258 | [#4] prototype.html Cycles:180 Average:4538.48 Median:5233.44 stddev:1329.72 (25.4%) stddev-sans-first:1295.15 09:06:01 INFO - PROCESS | 18258 | Values: 317.0 319.4 327.1 328.6 329.0 5232.6 5234.2 5265.2 5284.9 5295.8 5226.1 5230.8 5242.3 5265.9 5270.5 3853.2 3947.6 4086.5 4088.5 4108.8 4093.9 4100.3 4101.6 4105.9 4119.1 4075.1 4076.7 4078.3 4085.0 4085.7 3757.9 4002.7 4012.7 4070.5 4076.8 3470.3 3504.1 3507.6 3516.9 3520.6 4935.3 4950.8 4964.0 4967.0 4978.4 4398.1 4611.4 4651.1 4651.8 4674.0 5518.4 5530.1 5540.2 5545.0 5558.0 3854.2 3871.2 3876.3 3891.9 3904.8 5634.4 5719.9 5722.2 5751.7 5804.1 3812.5 3906.0 3910.4 3930.8 3936.4 3912.6 3916.6 3931.1 3934.8 3937.6 4604.8 4607.5 4611.7 4621.2 4631.9 5211.7 5525.4 5529.1 5543.8 5546.6 1394.1 1397.8 1406.0 1410.0 1412.4 857.5 929.8 939.3 961.6 962.4 4816.6 4838.7 4847.5 4851.7 4854.2 5568.3 5614.2 5615.4 5641.3 5643.1 4576.9 4778.2 4779.4 4789.7 4792.4 2986.1 2999.0 3010.6 3031.4 3034.8 5301.6 5326.7 5330.8 5355.7 5367.3 5585.1 5686.9 5723.5 5729.8 5788.9 5261.0 5276.3 5287.6 5301.4 5308.8 5408.7 5615.6 5626.9 5627.5 5628.3 5461.8 5496.9 5518.7 5524.5 5531.7 5195.5 5282.8 5286.8 5324.6 5326.9 3779.7 3985.1 3987.2 3987.5 4001.8 5693.5 5711.1 5723.9 5725.5 5728.6 5435.0 5456.0 5466.4 5517.0 5535.2 5339.8 5501.9 5511.6 5513.6 5525.2 5204.7 5420.1 5424.2 5435.7 5454.9 5394.5 5563.5 5566.8 5603.4 5606.0 5427.4 5438.2 5442.5 5451.1 5455.6 09:06:01 INFO - PROCESS | 18258 | 09:06:01 INFO - PROCESS | 18258 | [#5] yui.html Cycles:180 Average:13372.44 Median:45365.55 stddev:15635.13 (34.5%) stddev-sans-first:15650.00 09:06:01 INFO - PROCESS | 18258 | Values: 693.4 748.5 768.2 778.3 808.9 11931.3 12207.8 12295.4 12420.2 12427.9 12170.2 12230.7 12611.7 12643.5 12687.0 660.7 812.2 819.9 828.2 831.4 833.8 836.0 838.7 838.8 839.6 872.8 875.6 876.9 877.1 878.6 863.7 865.2 870.6 873.5 875.3 640.5 644.3 646.4 647.2 648.0 13095.5 13148.3 13230.5 13243.1 13303.5 12749.5 12855.7 13074.6 13133.2 13305.9 10232.4 10360.2 10416.1 10431.3 10442.8 3334.1 3361.3 3386.2 3407.7 3421.0 42487.2 45237.0 45494.1 45579.8 45600.1 9496.8 10063.0 10063.8 10127.9 10182.7 16640.4 16653.8 16671.7 16698.3 16761.6 6957.0 7015.6 7038.6 7048.3 7315.0 3976.3 3988.6 4035.2 4086.3 4102.6 2803.7 2859.6 2872.0 2872.2 2880.7 532.9 552.6 557.6 573.4 607.6 555.8 643.5 650.7 663.4 664.1 7817.1 7817.4 8042.0 8496.7 8515.6 546.3 549.8 553.4 557.6 560.0 3857.6 3990.0 4063.8 4090.3 4090.5 58057.0 59619.7 60090.2 60137.0 60202.1 50906.0 51977.0 52430.2 52481.2 52678.5 46223.5 46811.5 47644.3 48294.8 48462.0 7689.9 7786.2 7851.6 7943.6 7994.3 30983.5 31261.0 31335.5 31505.4 32057.7 32517.0 34853.0 38852.0 40910.4 42849.0 10606.6 10933.7 10969.5 10988.4 11160.9 11990.5 12016.9 12098.5 12374.6 12720.4 11079.7 11406.7 11435.3 11656.7 11983.4 10791.0 10841.5 10867.5 11128.6 11356.3 10711.5 10870.4 11256.4 11382.7 11452.1 9101.8 9172.0 9439.2 9710.3 9966.3 9603.0 9610.7 9636.0 9815.8 9889.6 09:06:01 INFO - PROCESS | 18258 | -------- Summary: end -------- 09:06:01 INFO - PROCESS | 18258 | 09:06:02 INFO - TEST-INFO | 18258: exit 0 09:06:02 INFO - TEST-OK | dromaeo_css | took 1115957ms 09:06:02 INFO - TEST-START | kraken 09:06:02 INFO - operating with platform_type : linux_ 09:06:02 INFO - Initialising browser for kraken test... 09:06:02 INFO - TEST-INFO | started process 18491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdE7o0e/profile http://localhost:52306/getInfo.html) 09:06:06 INFO - PROCESS | 18491 | 09:06:06 INFO - PROCESS | 18491 | (process:18558): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:06:06 INFO - PROCESS | 18491 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 09:06:06 INFO - PROCESS | 18491 | __metrics Screen width/height:1600/1200 09:06:06 INFO - PROCESS | 18491 | colorDepth:24 09:06:06 INFO - PROCESS | 18491 | Browser inner width/height: 1024/697 09:06:06 INFO - PROCESS | 18491 | __metrics 09:06:07 ERROR - PROCESS | 18491 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:06:08 INFO - TEST-INFO | 18491: exit 0 09:06:08 INFO - Browser initialized. 09:06:08 INFO - Running cycle 1/1 for kraken test... 09:06:08 INFO - TEST-INFO | started process 18609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdE7o0e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:10 INFO - PROCESS | 18609 | 09:06:10 INFO - PROCESS | 18609 | (process:18670): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:06:20 INFO - PROCESS | 18609 | RSS: Main: 164282368 09:06:20 INFO - PROCESS | 18609 | 09:06:23 INFO - PROCESS | 18609 | Cycle 1(1): loaded http://localhost:52306/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52306/tests/kraken/driver.html?testName=audio-beat-detection) 09:06:24 INFO - PROCESS | 18609 | RSS: Main: 168443904 09:06:24 INFO - PROCESS | 18609 | 09:06:27 INFO - PROCESS | 18609 | Cycle 1(1): loaded http://localhost:52306/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52306/tests/kraken/driver.html?testName=audio-dft) 09:06:27 INFO - PROCESS | 18609 | RSS: Main: 171716608 09:06:27 INFO - PROCESS | 18609 | 09:06:30 INFO - PROCESS | 18609 | Cycle 1(1): loaded http://localhost:52306/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52306/tests/kraken/driver.html?testName=audio-fft) 09:06:31 INFO - PROCESS | 18609 | RSS: Main: 162131968 09:06:31 INFO - PROCESS | 18609 | 09:06:33 INFO - PROCESS | 18609 | Cycle 1(1): loaded http://localhost:52306/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52306/tests/kraken/driver.html?testName=audio-oscillator) 09:06:34 INFO - PROCESS | 18609 | RSS: Main: 162705408 09:06:34 INFO - PROCESS | 18609 | 09:06:36 INFO - PROCESS | 18609 | Cycle 1(1): loaded http://localhost:52306/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52306/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:06:36 INFO - PROCESS | 18609 | RSS: Main: 164114432 09:06:36 INFO - PROCESS | 18609 | 09:06:40 INFO - PROCESS | 18609 | Cycle 1(1): loaded http://localhost:52306/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52306/tests/kraken/driver.html?testName=imaging-darkroom) 09:06:40 INFO - PROCESS | 18609 | RSS: Main: 164302848 09:06:40 INFO - PROCESS | 18609 | 09:06:44 INFO - PROCESS | 18609 | Cycle 1(1): loaded http://localhost:52306/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52306/tests/kraken/driver.html?testName=imaging-desaturate) 09:06:44 INFO - PROCESS | 18609 | RSS: Main: 164081664 09:06:44 INFO - PROCESS | 18609 | 09:06:47 INFO - PROCESS | 18609 | Cycle 1(1): loaded http://localhost:52306/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52306/tests/kraken/driver.html?testName=json-parse-financial) 09:06:48 INFO - PROCESS | 18609 | RSS: Main: 164577280 09:06:48 INFO - PROCESS | 18609 | 09:06:50 INFO - PROCESS | 18609 | Cycle 1(1): loaded http://localhost:52306/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52306/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:06:50 INFO - PROCESS | 18609 | RSS: Main: 164941824 09:06:50 INFO - PROCESS | 18609 | 09:06:52 INFO - PROCESS | 18609 | Cycle 1(1): loaded http://localhost:52306/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52306/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:06:53 INFO - PROCESS | 18609 | RSS: Main: 164720640 09:06:53 INFO - PROCESS | 18609 | 09:06:55 INFO - PROCESS | 18609 | Cycle 1(1): loaded http://localhost:52306/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52306/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:06:56 INFO - PROCESS | 18609 | RSS: Main: 165154816 09:06:56 INFO - PROCESS | 18609 | 09:06:58 INFO - PROCESS | 18609 | Cycle 1(1): loaded http://localhost:52306/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:06:59 INFO - PROCESS | 18609 | RSS: Main: 165756928 09:06:59 INFO - PROCESS | 18609 | 09:07:02 INFO - PROCESS | 18609 | Cycle 1(1): loaded http://localhost:52306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:07:03 INFO - PROCESS | 18609 | RSS: Main: 165351424 09:07:03 INFO - PROCESS | 18609 | 09:07:04 INFO - PROCESS | 18609 | Cycle 1(1): loaded http://localhost:52306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52306/tests/kraken/driver.html?testName=ai-astar) 09:07:05 INFO - PROCESS | 18609 | RSS: Main: 166789120 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | __start_tp_report 09:07:05 INFO - PROCESS | 18609 | _x_x_mozilla_page_load 09:07:05 INFO - PROCESS | 18609 | _x_x_mozilla_page_load_details 09:07:05 INFO - PROCESS | 18609 | |i|pagename|runs| 09:07:05 INFO - PROCESS | 18609 | |0;ai-astar;114;108;115;119;115;128;113;117;116;114 09:07:05 INFO - PROCESS | 18609 | |1;audio-beat-detection;158;134;159;181;136;158;160;135;201;138 09:07:05 INFO - PROCESS | 18609 | |2;audio-dft;166;165;165;169;170;164;165;165;167;164 09:07:05 INFO - PROCESS | 18609 | |3;audio-fft;74;75;75;160;76;75;74;74;158;76 09:07:05 INFO - PROCESS | 18609 | |4;audio-oscillator;95;95;148;97;95;97;138;95;95;146 09:07:05 INFO - PROCESS | 18609 | |5;imaging-gaussian-blur;118;118;117;117;118;118;117;117;119;118 09:07:05 INFO - PROCESS | 18609 | |6;imaging-darkroom;149;149;147;149;149;148;148;148;149;148 09:07:05 INFO - PROCESS | 18609 | |7;imaging-desaturate;97;97;97;96;97;96;96;97;96;96 09:07:05 INFO - PROCESS | 18609 | |8;json-parse-financial;66;63;64;65;73;64;64;82;64;61 09:07:05 INFO - PROCESS | 18609 | |9;json-stringify-tinderbox;66;65;64;65;65;65;64;65;64;65 09:07:05 INFO - PROCESS | 18609 | |10;stanford-crypto-aes;85;85;89;86;86;85;87;85;90;85 09:07:05 INFO - PROCESS | 18609 | |11;stanford-crypto-ccm;142;138;141;141;140;148;136;149;171;141 09:07:05 INFO - PROCESS | 18609 | |12;stanford-crypto-pbkdf2;179;189;178;177;175;174;182;175;178;178 09:07:05 INFO - PROCESS | 18609 | |13;stanford-crypto-sha256-iterative;75;76;73;73;73;72;73;73;73;72 09:07:05 INFO - PROCESS | 18609 | __end_tp_report 09:07:05 INFO - PROCESS | 18609 | __start_cc_report 09:07:05 INFO - PROCESS | 18609 | _x_x_mozilla_cycle_collect,915 09:07:05 INFO - PROCESS | 18609 | __end_cc_report 09:07:05 INFO - PROCESS | 18609 | __startTimestamp1460563625225__endTimestamp 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | ------- Summary: start ------- 09:07:05 INFO - PROCESS | 18609 | Number of tests: 14 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | [#0] ai-astar Cycles:10 Average:115.90 Median:115.50 stddev:5.13 (4.4%) stddev-sans-first:5.40 09:07:05 INFO - PROCESS | 18609 | Values: 114.0 108.0 115.0 119.0 115.0 128.0 113.0 117.0 116.0 114.0 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | [#1] audio-beat-detection Cycles:10 Average:156.00 Median:158.50 stddev:21.94 (13.8%) stddev-sans-first:23.26 09:07:05 INFO - PROCESS | 18609 | Values: 158.0 134.0 159.0 181.0 136.0 158.0 160.0 135.0 201.0 138.0 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | [#2] audio-dft Cycles:10 Average:166.00 Median:165.50 stddev:2.05 (1.2%) stddev-sans-first:2.18 09:07:05 INFO - PROCESS | 18609 | Values: 166.0 165.0 165.0 169.0 170.0 164.0 165.0 165.0 167.0 164.0 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | [#3] audio-fft Cycles:10 Average:91.70 Median:75.00 stddev:35.48 (47.3%) stddev-sans-first:37.05 09:07:05 INFO - PROCESS | 18609 | Values: 74.0 75.0 75.0 160.0 76.0 75.0 74.0 74.0 158.0 76.0 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:95.00 stddev:23.54 (24.8%) stddev-sans-first:24.32 09:07:05 INFO - PROCESS | 18609 | Values: 95.0 95.0 148.0 97.0 95.0 97.0 138.0 95.0 95.0 146.0 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 09:07:05 INFO - PROCESS | 18609 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 119.0 118.0 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 09:07:05 INFO - PROCESS | 18609 | Values: 149.0 149.0 147.0 149.0 149.0 148.0 148.0 148.0 149.0 148.0 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:07:05 INFO - PROCESS | 18609 | Values: 97.0 97.0 97.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:64.50 stddev:6.26 (9.7%) stddev-sans-first:6.63 09:07:05 INFO - PROCESS | 18609 | Values: 66.0 63.0 64.0 65.0 73.0 64.0 64.0 82.0 64.0 61.0 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 09:07:05 INFO - PROCESS | 18609 | Values: 66.0 65.0 64.0 65.0 65.0 65.0 64.0 65.0 64.0 65.0 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.00 stddev:1.83 (2.1%) stddev-sans-first:1.88 09:07:05 INFO - PROCESS | 18609 | Values: 85.0 85.0 89.0 86.0 86.0 85.0 87.0 85.0 90.0 85.0 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:141.50 stddev:10.07 (7.1%) stddev-sans-first:10.63 09:07:05 INFO - PROCESS | 18609 | Values: 142.0 138.0 141.0 141.0 140.0 148.0 136.0 149.0 171.0 141.0 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:178.00 stddev:4.35 (2.4%) stddev-sans-first:4.61 09:07:05 INFO - PROCESS | 18609 | Values: 179.0 189.0 178.0 177.0 175.0 174.0 182.0 175.0 178.0 178.0 09:07:05 INFO - PROCESS | 18609 | 09:07:05 INFO - PROCESS | 18609 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:73.00 stddev:1.25 (1.7%) stddev-sans-first:1.17 09:07:05 INFO - PROCESS | 18609 | Values: 75.0 76.0 73.0 73.0 73.0 72.0 73.0 73.0 73.0 72.0 09:07:05 INFO - PROCESS | 18609 | -------- Summary: end -------- 09:07:05 INFO - PROCESS | 18609 | 09:07:06 INFO - TEST-INFO | 18609: exit 0 09:07:06 INFO - TEST-OK | kraken | took 64221ms 09:07:06 INFO - SUITE-END | took 1180s 09:07:06 INFO - Completed test suite (00:19:40) 09:07:06 INFO - javascript benchmark 09:07:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.6353510508525, 2651.70831208567, 2674.6790385153786, 2685.1944416675005, 2695.4070104577, 4687.953120468795, 4702.506236845129, 4726.810927562898, 4786.09064277787, 4846.030793841237, 4638.837640682568, 4652.418447694038, 4679.766011699418, 4692.882677933053, 4704.294355846625, 4240.936385954213, 4307.483102027745, 4353.825846966118, 4358.3244597087505, 4368.62866656333, 4267.850625228118, 4269.573042695721, 4301.978490107545, 4331.45856767904, 4399.714018588797, 4225.767582782945, 4241.448611680462, 4269.210196113729, 4287.335463003239, 4297.527272000078, 4269.7224680395675, 4284.250256205183, 4288.378185163134, 4325.199838029975, 4338.848140315105, 4146.3780432935, 4278.251306021434, 4285.421468101828, 4316.417283666696, 4322.7190232634775, 4558.111168322179, 4622.237330840408, 4622.6070783983405, 4676.228422310314, 4677.532246775329, 5078.949210507884, 5106.361704786902, 5112.079825631385, 5114.28400023997, 5126.256692779563, 4937.851864444036, 5043.067032598944, 5110.3356563646485, 5117.974410127963, 5167.767450464738, 4728.692634978715, 4749.121412538622, 4753.144434001843, 4756.619470442356, 4799.808007679723, 5177.948220517746, 5178.663386879841, 5181.481851814789, 5199.766010529535, 5227.869303267449, 4786.377770889762, 4938.654294199371, 4976.850694479172, 4981.476944920803, 5026.246063090565, 4895.975520122377, 4991.151504244287, 5019.945811379578, 5078.873028174326, 5113.463086375877, 4943.307936888838, 4955.876103097451, 4963.875903102379, 4985.750712464363, 5011.799528018912, 4837.467878533358, 4933.28467372229, 4940.061388336277, 4996.0, 5029.421616514148, 3870.729048966545, 3877.747946383476, 3882.7087968402484, 3902.687784977195, 3912.7456715313415, 3453.930921381558, 3455.7926524408617, 3471.7569770116356, 3478.5999610044664, 3496.230829217568, 4283.357496375506, 4357.3899654048455, 4413.668974826901, 4435.379046933432, 4459.509453960127, 5059.924101138486, 5077.289179514871, 5085.4914508548845, 5103.770330335144, 5107.055194788976, 4432.069265454226, 4435.977820110943, 4438.533953934855, 4440.666949978765, 4445.466544014739, 4395.604395604411, 4476.4180656514445, 4502.729836209838, 4514.774261286988, 4538.52345503724, 4786.856394308176, 4800.567948884617, 4809.110314591811, 4827.493113223061, 4828.589569886599, 5022.1964485683575, 5031.471695471922, 5048.141815891381, 5069.721165335942, 5102.1326374515675, 4831.227003679394, 4859.878503037311, 4863.148948933993, 4870.561649451566, 4897.069556784199, 4946.208606622923, 4959.380077490314, 4973.6269779765935, 4980.203167493184, 5014.548690617862, 4926.433460152129, 5033.144365457808, 5051.838077242328, 5080.669756465818, 5086.821961231339, 4836.443808962014, 4879.512048795092, 4955.752212389438, 4995.575376093073, 5009.649324547247, 4887.853364399074, 4906.55840974314, 4908.239222920453, 4909.189983652657, 4921.778519966539, 4775.498572649822, 4804.927926081042, 4818.10864989978, 4849.030193961293, 4859.416869975626, 4878.829240976691, 5002.599792016703, 5023.146065168857, 5033.766727151871, 5073.365829271341, 4831.347768051409, 4844.975775121102, 4851.854444366674, 4860.9513904861915, 4898.3142360068905], "value": 4608.37541566327, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.8596336879148, 603.4538742438094, 606.9848253793657, 624.750099960016, 641.3682522715122, 33646.327073458546, 34790.304193916105, 34843.0, 34931.82534087326, 35038.29923401531, 37209.0, 38054.8097259514, 38138.42792358117, 38147.23705525895, 38210.235795284076, 7601.543907365548, 7873.094594121663, 7875.684972601089, 7878.212178782133, 7878.25156610124, 7705.576193309365, 7858.960705196495, 7873.645685944118, 8063.193680631948, 8075.475094118863, 8007.51954882706, 8008.27925486706, 8055.113937466874, 8059.314958228558, 8092.514449133041, 7998.200179982014, 8019.278264956153, 8027.678892844308, 8039.07550631679, 8080.151584083704, 7768.7669369918995, 7847.9215207847765, 7881.842363152705, 8014.599270036533, 8056.0, 37584.0, 38476.0, 38494.615053849666, 38597.614023859685, 38738.22523549541, 2571.691397032368, 3005.549167624852, 3021.6222972128485, 3083.1367217179227, 3089.7373723233554, 24750.876245618656, 25186.11848585309, 25548.872255638787, 26066.478670426484, 28937.710622893712, 3434.1929646533044, 3438.673326034023, 3440.776349537272, 3520.9088277280193, 3536.664016918389, 210251.0, 211069.0, 211252.0, 211387.0, 211904.99999999846, 53070.20394694083, 53198.73400632972, 53260.0, 53381.466185338424, 53426.46573534293, 56775.0, 58336.4166358331, 59931.0, 60130.0, 60720.0, 13791.310434478237, 13909.095908765898, 14067.929660351632, 14074.366653500618, 14111.15333079998, 10643.574257029632, 10776.515056822462, 10847.620333288454, 10902.618408355669, 10920.0, 17817.287308507774, 17964.730529042074, 18619.534511637048, 18651.533711657317, 18790.53023674419, 6798.66006699663, 6836.350546698056, 6875.243723190445, 7102.360787529147, 7109.8933515997305, 787.52354825331, 825.6037102190862, 827.995860020708, 851.5997481183833, 912.6623149434752, 27025.729742702322, 27502.587461188097, 27639.86180069087, 27797.861010694818, 27820.86089569539, 959.822432849925, 981.2738573455734, 996.3772642098688, 1046.3617193511952, 1047.4134484688445, 14366.209858457885, 14476.767131773635, 14561.635959101108, 14650.853491465163, 14704.632384190267, 361326.0, 368018.0, 368843.0, 369482.0, 373560.0, 50030.0, 50457.0, 50541.0, 50551.24173137406, 50555.49444505582, 1238.294172321786, 1265.8101284807353, 1281.5002149161835, 1282.0, 1369.2469141971876, 25414.364640884127, 26349.0, 26953.800625855773, 27296.863515682293, 27440.725592744617, 42394.1521169581, 42967.0, 43089.56910430855, 43137.0, 43286.0, 302399.0, 307642.0, 308132.0, 308570.0, 309410.0, 25596.488070238862, 25621.87189064043, 25774.613380798928, 25779.871100644377, 25812.09657661973, 43159.78420107879, 43364.78317608392, 43487.347689784045, 43830.780846095564, 44116.55883441253, 36812.21441212625, 37436.06409839776, 37498.625013749515, 37824.43263350997, 38121.23757524778, 37009.62990370062, 37043.0, 37049.0, 37110.8144459276, 37473.250534988605, 29884.551731723608, 32667.673323267412, 33916.0, 34444.0, 35313.1171720709, 30201.825324630026, 31345.686543134278, 32286.35427291488, 35753.64246357607, 37152.81423592865, 23072.192473263356, 23115.768842312034, 23225.419364516023, 23239.535209296057, 23350.0], "value": 17322.39525836168, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.68610367291467, 386.8876978686275, 389.0875896023825, 389.6279053503904, 407.92249472600224, 15448.0, 17302.394416195435, 17918.104094795257, 18041.909790451064, 18072.096395180237, 16067.357305707787, 16907.74638380422, 16974.49076527706, 17173.82826171738, 17212.31150753968, 5031.572316353115, 5170.3795544534705, 5197.766100525467, 5213.843584692465, 5225.085610018251, 3686.2627474505207, 5554.444555544434, 5885.617434866741, 5896.204012458306, 5904.202932604107, 5670.829875103754, 5855.180274761537, 5855.8536036599, 5882.14708867214, 5903.439173278532, 5839.124131380285, 5854.88290234195, 5876.676782776945, 5889.7644094236175, 5891.351951285355, 4609.262517997138, 4946.109700253989, 5139.614528910347, 5162.096633089194, 5185.222216667492, 11667.883321166764, 11728.237664551862, 11792.174547781658, 11865.762684746343, 11901.33381326615, 2007.4278830533228, 2012.5974805038904, 2014.9294774682962, 2033.044469099521, 2042.7548694156649, 9070.092990700878, 9077.682281120195, 9179.127982841619, 9367.156955874005, 9417.717468475958, 1701.7277235642239, 1724.913754312292, 1732.610162713392, 1758.1824451630052, 1777.4489908128392, 69706.0, 69805.30194698038, 70652.646736766, 71128.0, 71187.64406177988, 10055.346402483816, 10098.848517272247, 10153.746156346151, 10158.593656253666, 10275.897241027644, 14336.713265734836, 14468.493602723855, 14507.564773056825, 14555.41778328855, 14555.78166327506, 7109.466789990772, 7185.497015208885, 7269.709211631475, 7338.669759860819, 7354.448416368794, 6563.409293163638, 6603.603783772989, 6614.6361950093205, 6675.499337549606, 6764.5603035802515, 4363.5418281080665, 4386.736795792199, 4401.801918913657, 4420.9336859947125, 4509.932351014738, 1700.3708627807544, 1770.7963584187983, 1878.5773201029933, 1904.228787341129, 1916.2335065973723, 413.2334519466407, 828.3083625173048, 877.1535468273147, 878.2183856367838, 889.4129874283071, 9594.760130996781, 9952.15406690425, 9953.900460995297, 10056.994300569884, 10076.29465937392, 410.36188726529934, 412.3381971935061, 417.7180403227809, 418.4016855896037, 419.28511887232196, 5336.386315573681, 5412.675239485643, 5415.268938693304, 5427.158790387496, 5578.442155784389, 309212.0, 426346.0, 432342.0, 432738.0, 445904.0, 81543.0, 83043.0, 83663.0, 83990.0, 84588.57705711432, 429.6992105526207, 433.37810242302396, 437.98905027373934, 439.4353256066004, 441.66433510531584, 9259.76850578741, 9438.38650487716, 9710.417374957526, 9740.172085372822, 9760.365576237522, 30990.535141973338, 31369.0, 32295.838520807247, 34051.829740851135, 34260.82869585636, 40847.1830563393, 41163.0, 41195.0, 41414.58585414107, 41433.0, 7304.160021597584, 7332.156801967629, 7345.192028876926, 7481.2144724805285, 7675.5010924289745, 8621.913780862362, 10896.891031089905, 11026.944865275622, 11109.833352499558, 11635.243709158878, 9314.068593140631, 9405.106514881076, 9500.334976551576, 9504.95247523758, 9547.283953703361, 9428.528573571431, 9478.146966773023, 9663.565139568596, 9730.464824434725, 9936.453495057553, 8495.702650407206, 9629.470379129216, 9711.36876103051, 9807.166390856857, 10010.349327293703, 6451.41937225652, 6797.252302246848, 7216.458765592706, 7780.961095194488, 7806.258405451473, 9226.308026897876, 9318.860217096613, 9415.0, 9581.90418095838, 9746.85379719319], "value": 7320.735659730667, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.3638735343802, 1492.3218596779413, 1651.9504414867558, 1773.0514174916423, 1779.0393187678653, 6909.378155965962, 7571.4321425893, 7593.430492713055, 7863.528188308698, 7891.053073631165, 7613.771586852389, 7673.654685539164, 7679.616019199046, 7721.03487064117, 7721.266479684435, 2270.6821045053707, 2299.1378233162563, 2299.9195028174017, 2300.056976639578, 2312.063614236237, 2201.0755482697227, 2209.69064330993, 2263.7509873913937, 2268.6483595042796, 2270.114655284432, 2269.682244485765, 2271.761465046163, 2272.3864556569715, 2282.463621049052, 2297.8161747060194, 2194.572058448603, 2196.5716685246384, 2204.9779502205092, 2213.8339624528144, 2215.7784221577795, 2156.277646988261, 2160.4274867160216, 2164.1559791681257, 2188.2997440818945, 2189.5620875824898, 7837.529748215068, 7912.248336408032, 7969.481983671043, 7986.161453047463, 8069.757907262791, 4606.516315786861, 4734.668573199878, 4740.478547359788, 4791.496892826272, 4794.808207671724, 2933.1200639808185, 3077.815331080142, 3196.392685389792, 3203.2312245061253, 3235.6117265928006, 966.7244835221928, 1016.1565900302732, 1020.7346090016575, 1021.3310281765456, 1036.6164519127894, 10599.523021464052, 10600.310979786289, 10618.0, 10658.094062004739, 10694.786104277871, 4035.899102522402, 4223.260929337353, 4328.199283132568, 4363.712704752105, 4412.073464572476, 9231.261499080192, 9238.907610923805, 9265.44407335562, 9322.394044387092, 9342.626294948126, 4582.725036497821, 4591.1965406053805, 4614.192516309632, 4630.513796051366, 4631.235846085426, 3690.9630903691154, 4281.272183728774, 4300.075483770942, 4323.978380108079, 4434.911301774011, 3618.751530721897, 3693.1505753676806, 3747.3816820224356, 3795.8291876865605, 3851.807409629507, 1236.5919246648764, 1241.5902752091788, 1242.8260043593905, 1244.0296568676447, 1257.6289994451658, 861.1388611388611, 876.6756300168978, 876.8860048193694, 878.0297770962994, 879.8680197970356, 5596.58025648078, 5624.29696287964, 5642.435756424325, 5670.489655930904, 5808.477237048686, 927.2859897878595, 974.6491263145263, 994.1202036198017, 997.6432052408718, 1016.1870503597092, 3529.4705794130573, 3730.5523337199165, 3811.866584669523, 3824.7896365700153, 3829.9808500957874, 9578.0, 9909.801803963881, 9960.750981225527, 9960.950195248977, 10048.296619236584, 8537.658493660185, 8950.418222815497, 9814.656487023063, 9819.901800982041, 9869.802603947881, 7285.307895749896, 7298.087739032621, 7320.487565870338, 7425.071866016748, 7450.180480147288, 5153.587712983027, 5409.188621706776, 5463.180522921593, 5520.309961254843, 5581.888362232814, 8289.751307460785, 8547.102554231717, 8702.869456958277, 8903.955480222558, 9001.414908030956, 8925.910740892508, 8976.0, 9199.310051746012, 9330.673426430043, 9361.251099911855, 6290.119383286252, 6820.488463365168, 7036.437085033287, 7073.540219885691, 7180.3537681608905, 7581.886271705818, 7620.504667196615, 7633.2366763323225, 7634.236576342321, 7683.769486915401, 6604.801855944329, 6971.372576468142, 6998.300169982961, 7038.190608080136, 7045.788626341218, 6815.454763618998, 6826.419754320938, 6844.384005439534, 6890.345417185359, 6939.930600693929, 6508.544401891822, 6516.413522782783, 6592.406683398517, 6628.07206991012, 6651.102101216467, 4757.858114052671, 4785.9042819144115, 4806.134895718804, 4854.393200849894, 4866.80532778699, 4832.734199619054, 4833.226683730586, 4836.564709176191, 4838.975805120952, 4852.781624826821], "value": 4271.2637671417115, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.9619645642523, 319.43778949049664, 327.1151535097561, 328.6270083455279, 328.9539464474974, 5232.633715639907, 5234.241035049916, 5265.236540701596, 5284.867878303035, 5295.788168473261, 5226.132661830246, 5230.764615592298, 5242.292290540776, 5265.921011184835, 5270.4729527047375, 3853.2486165197797, 3947.605239476058, 4086.509618845743, 4088.4889388826396, 4108.753474791507, 4093.9181216375655, 4100.343944968806, 4101.610347017028, 4105.876823695279, 4119.134981653856, 4075.1442197138635, 4076.714629975888, 4078.3270760324513, 4084.97957510212, 4085.6935729820384, 3757.9436308455397, 4002.7198096133284, 4012.6589239914642, 4070.470838790953, 4076.8381011411752, 3470.3059388122224, 3504.0539054455407, 3507.632023510833, 3516.859325626972, 3520.6303338149637, 4935.333729946447, 4950.777215025332, 4963.975180124076, 4967.0, 4978.377702787152, 4398.119231903109, 4611.4005179326805, 4651.116287905287, 4651.790669419885, 4674.0, 5518.392976772552, 5530.142827861688, 5540.2243685884005, 5545.0, 5557.972210138963, 3854.209886973164, 3871.2257548490416, 3876.2828876657627, 3891.8637847675477, 3904.824282907276, 5634.380013293797, 5719.941810765022, 5722.227499287626, 5751.712414379264, 5804.129380592903, 3812.5234345706785, 3906.0430194602504, 3910.354791459434, 3930.8231129598666, 3936.4488971544006, 3912.628300311466, 3916.5691773904846, 3931.1154990126993, 3934.8229329680235, 3937.6062393760394, 4604.8388306409115, 4607.493175750665, 4611.746353950565, 4621.168189725881, 4631.907361852744, 5211.739413029409, 5525.419830917776, 5529.087700529368, 5543.77824887, 5546.55627549795, 1394.0868730981224, 1397.7559971625262, 1405.9947137796526, 1409.9647508812361, 1412.4067891485602, 857.5497863621524, 929.8326301265702, 939.3189937295542, 961.6345788600287, 962.4273557233435, 4816.590589799836, 4838.685485443435, 4847.515248475124, 4851.708897466164, 4854.247591623304, 5568.331800184003, 5614.242077319591, 5615.382307946123, 5641.266635337462, 5643.125315576092, 4576.88557786058, 4778.1638213312535, 4779.354787103696, 4789.688670236424, 4792.412097467329, 2986.0743169617053, 2998.970010299869, 3010.5935698680837, 3031.439183751013, 3034.787564870438, 5301.575873930076, 5326.733663316819, 5330.760115794798, 5355.651882627694, 5367.329083864517, 5585.128981791064, 5686.886262274814, 5723.484886360247, 5729.762684083479, 5788.88422231553, 5261.0, 5276.34045744282, 5287.629865909426, 5301.416844147141, 5308.840734777963, 5408.729563521887, 5615.606907516435, 5626.915596265977, 5627.465390787868, 5628.268325117709, 5461.781528738965, 5496.862578435571, 5518.724063796874, 5524.502794748492, 5531.7234138292115, 5195.454477279831, 5282.788688452419, 5286.81496147633, 5324.600654950972, 5326.866828329323, 3779.6787273082095, 3985.143194213258, 3987.1626958339075, 3987.521497420328, 4001.7999100045463, 5693.544516438592, 5711.114777209373, 5723.856903577277, 5725.456081672234, 5728.598998070095, 5434.989054050026, 5456.0, 5466.3713672928125, 5516.972415138059, 5535.197396377584, 5339.7597108131, 5501.909274475834, 5511.614187006871, 5513.58648101386, 5525.226468294361, 5204.739763011758, 5420.13277875538, 5424.24060631504, 5435.728213589384, 5454.890902182014, 5394.460553944574, 5563.499285064364, 5566.77732890696, 5603.35561410443, 5606.018946684396, 5427.402985671494, 5438.184272359178, 5442.455754424526, 5451.073317535949, 5455.563554915518], "value": 4117.326679172688, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.4313862632644, 748.5471289869629, 768.2356055724554, 778.3034184404958, 808.8503626829041, 11931.343776092312, 12207.816882746754, 12295.446704898279, 12420.192687475319, 12427.937860310685, 12170.208936419127, 12230.694232644188, 12611.684707882285, 12643.49426022958, 12687.0, 660.709287913319, 812.1513018895268, 819.9057108432518, 828.225609055535, 831.4387788242911, 833.7790485521342, 835.9582020898961, 838.6729175621513, 838.7567605394428, 839.588601585225, 872.7861673889906, 875.5797217335651, 876.8860048193726, 877.1272583779148, 878.5914549734372, 863.6718047142109, 865.2040123086775, 870.5908223135116, 873.4890089297705, 875.2866413872705, 640.4940097323109, 644.2655372874926, 646.447287569131, 647.1522305779444, 647.9805605831832, 13095.541656042087, 13148.342582870819, 13230.470781168742, 13243.072984891061, 13303.534376296782, 12749.490020399266, 12855.733625471466, 13074.607761767162, 13133.212007279593, 13305.869001134915, 10232.43721595312, 10360.218520240134, 10416.114630256438, 10431.269811113225, 10442.843357349646, 3334.1164591383304, 3361.344537815127, 3386.1703882548686, 3407.693307602328, 3421.0421082097055, 42487.150256994995, 45237.0, 45494.09011819745, 45579.77210113928, 45600.08799823985, 9496.762580935394, 10063.0, 10063.798724025624, 10127.949360253151, 10182.694519164437, 16640.417585384454, 16653.750193747102, 16671.749923751155, 16698.332066717194, 16761.580960476087, 6957.026016357714, 7015.649217539205, 7038.6480675965995, 7048.330408611174, 7314.96342518284, 3976.264391087658, 3988.6011398860464, 4035.233305671913, 4086.3257562501853, 4102.630763231324, 2803.71962803718, 2859.628248327704, 2871.9856400717863, 2872.1527149490535, 2880.683124856264, 532.8747744280091, 552.6324993879106, 557.5985290590768, 573.3607028163651, 607.5959486941223, 555.7610227602089, 643.5302229372584, 650.6551527690332, 663.3830537599982, 664.0934283452041, 7817.140114587391, 7817.413693972975, 8041.959790201012, 8496.70261540843, 8515.57422128891, 546.336201515153, 549.7608540284989, 553.3885057011944, 557.637535601862, 559.9580031497654, 3857.556381016163, 3989.9800500997308, 4063.8187753802595, 4090.284200264942, 4090.5091389033505, 58057.0, 59619.70190149022, 60090.19729408125, 60137.0, 60202.096968545506, 50906.0, 51977.0, 52430.213546796826, 52481.2127818083, 52678.473215268124, 46223.53776462192, 46811.5318846814, 47644.28533571999, 48294.758526207144, 48462.0, 7689.923100769144, 7786.221377862168, 7851.568163751049, 7943.563104029334, 7994.2805147537, 30983.535246970863, 31261.0, 31335.529967050057, 31505.369892602477, 32057.67942320547, 32517.0, 34853.0, 38852.0, 40910.386344204264, 42849.0, 10606.628767993083, 10933.671989840317, 10969.474335682498, 10988.395638239974, 11160.944195279297, 11990.520379184734, 12016.939915300718, 12098.516059357527, 12374.566890159162, 12720.363981801058, 11079.72300692489, 11406.657800266004, 11435.256708313933, 11656.650300491, 11983.400829958642, 10791.0, 10841.482192493215, 10867.51096200657, 11128.554857805597, 11356.318620882774, 10711.464426778786, 10870.402127883042, 11256.380899050631, 11382.715432114263, 11452.14108941816, 9101.817963640822, 9171.954140229256, 9439.244860411289, 9710.271729620166, 9966.252531060345, 9603.0, 9610.66362677303, 9636.0, 9815.803683926424, 9889.554970026222], "value": 6126.978199172513, "unit": "score"}], "name": "dromaeo_css", "value": 6307.569142152861, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 115.0, 119.0, 115.0, 128.0, 113.0, 117.0, 116.0, 114.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 134.0, 159.0, 181.0, 136.0, 158.0, 160.0, 135.0, 201.0, 138.0], "value": 156.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 165.0, 169.0, 170.0, 164.0, 165.0, 165.0, 167.0, 164.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 160.0, 76.0, 75.0, 74.0, 74.0, 158.0, 76.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 148.0, 97.0, 95.0, 97.0, 138.0, 95.0, 95.0, 146.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 119.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 147.0, 149.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 64.0, 65.0, 73.0, 64.0, 64.0, 82.0, 64.0, 61.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 89.0, 86.0, 86.0, 85.0, 87.0, 85.0, 90.0, 85.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 138.0, 141.0, 141.0, 140.0, 148.0, 136.0, 149.0, 171.0, 141.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 189.0, 178.0, 177.0, 175.0, 174.0, 182.0, 175.0, 178.0, 178.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 73.0, 73.0, 73.0, 72.0, 73.0, 73.0, 73.0, 72.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1616.5, "alertThreshold": 2.0}]} 09:07:06 INFO - Return code: 0 09:07:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:07:06 ERROR - # TBPL SUCCESS # 09:07:06 INFO - Running post-action listener: _resource_record_post_action 09:07:06 INFO - Running post-run listener: _resource_record_post_run 09:07:07 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 519204864; Read time: 0; Write time: 735084 09:07:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233697280; Read time: 0; Write time: 371552 09:07:07 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 285507584; Read time: 0; Write time: 363532 09:07:07 INFO - Running post-run listener: _upload_blobber_files 09:07:07 INFO - Blob upload gear active. 09:07:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:07:07 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 09:07:07 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'] 09:07:07 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 09:07:08 INFO - (blobuploader) - INFO - Open directory for files ... 09:07:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:07:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:07:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:09 INFO - (blobuploader) - INFO - Done attempting. 09:07:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:07:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:07:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:09 INFO - (blobuploader) - INFO - Done attempting. 09:07:09 INFO - (blobuploader) - INFO - Iteration through files over. 09:07:09 INFO - Return code: 0 09:07:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:07:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:07:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/862cd3703f56f4240f55a12d820372c839d4ec5bfb3d934e515d098cdfbd5117013cb4fa88e57161e93f0a5c8ecf1a148139cf46ea785a14dd60efa5b06f8c12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/748fd0af2116890d1fcdd38a597fd76ac05dd88028d57f0db8c7b03148d9b30fdd93bf71cbd8b75227d80bcc9dada8f5be64b54113f2a962c12cbed843ea467f"} 09:07:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:07:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:07:09 INFO - Contents: 09:07:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/862cd3703f56f4240f55a12d820372c839d4ec5bfb3d934e515d098cdfbd5117013cb4fa88e57161e93f0a5c8ecf1a148139cf46ea785a14dd60efa5b06f8c12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/748fd0af2116890d1fcdd38a597fd76ac05dd88028d57f0db8c7b03148d9b30fdd93bf71cbd8b75227d80bcc9dada8f5be64b54113f2a962c12cbed843ea467f"} 09:07:09 INFO - Running post-run listener: copy_logs_to_upload_dir 09:07:09 INFO - Copying logs to upload dir... 09:07:09 INFO - mkdir: /builds/slave/test/build/upload/logs 09:07:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.936844 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-13 09:07:08.162559) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 09:07:08.167075) ========= 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=52faae308a556c440401f8e5000001e8-1460560865.392701-623076491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/862cd3703f56f4240f55a12d820372c839d4ec5bfb3d934e515d098cdfbd5117013cb4fa88e57161e93f0a5c8ecf1a148139cf46ea785a14dd60efa5b06f8c12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/748fd0af2116890d1fcdd38a597fd76ac05dd88028d57f0db8c7b03148d9b30fdd93bf71cbd8b75227d80bcc9dada8f5be64b54113f2a962c12cbed843ea467f"} build_url:https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011357 build_url: 'https://queue.taskcluster.net/v1/task/X3FeDhhaRJqKQCMA7Nbl3A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/862cd3703f56f4240f55a12d820372c839d4ec5bfb3d934e515d098cdfbd5117013cb4fa88e57161e93f0a5c8ecf1a148139cf46ea785a14dd60efa5b06f8c12", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/748fd0af2116890d1fcdd38a597fd76ac05dd88028d57f0db8c7b03148d9b30fdd93bf71cbd8b75227d80bcc9dada8f5be64b54113f2a962c12cbed843ea467f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 09:07:08.196177) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 09:07:08.196520) ========= 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=52faae308a556c440401f8e5000001e8-1460560865.392701-623076491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 09:07:08.282213) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 09:07:08.282534) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 09:07:08.282862) ========= ========= Total master_lag: 0.26 =========