builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1460125606.25 results: success (0) buildid: 20160408064754 builduid: b136f7b4a417473ebae3cbe9bf6fc0c5 revision: 976abe6c1b315cfc94f476e6f4facfddea0f22b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:46.254835) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:46.255750) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:46.256566) ========= 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=a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006534 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:46.314196) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:46.314525) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:46.439056) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:46.439394) ========= 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=a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:46.492607) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:46.492909) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:46.493325) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:46.493694) ========= 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=a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-08 07:26:46-- 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% 46.4M=0s 2016-04-08 07:26:46 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169868 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:46.681029) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:46.681382) ========= 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=a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022551 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:46.733704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 07:26:46.734554) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 976abe6c1b315cfc94f476e6f4facfddea0f22b4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 976abe6c1b315cfc94f476e6f4facfddea0f22b4 --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=a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-08 07:26:47,111 truncating revision to first 12 chars 2016-04-08 07:26:47,111 Setting DEBUG logging. 2016-04-08 07:26:47,111 attempt 1/10 2016-04-08 07:26:47,111 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/976abe6c1b31?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 07:26:48,033 unpacking tar archive at: fx-team-976abe6c1b31/testing/mozharness/ program finished with exit code 0 elapsedTime=1.188646 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 07:26:47.938881) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:47.939243) ========= echo 976abe6c1b315cfc94f476e6f4facfddea0f22b4 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'976abe6c1b315cfc94f476e6f4facfddea0f22b4'] 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=a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 976abe6c1b315cfc94f476e6f4facfddea0f22b4 program finished with exit code 0 elapsedTime=0.003598 script_repo_revision: '976abe6c1b315cfc94f476e6f4facfddea0f22b4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:47.991219) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:47.991883) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 07:26:48.002780) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-08 07:26:48.003401) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:26:48 INFO - MultiFileLogger online at 20160408 07:26:48 in /builds/slave/test 07:26:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:26:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:26:48 INFO - {'append_to_log': False, 07:26:48 INFO - 'base_work_dir': '/builds/slave/test', 07:26:48 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:26:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:26:48 INFO - 'branch': 'Fx-Team-Non-PGO', 07:26:48 INFO - 'buildbot_json_path': 'buildprops.json', 07:26:48 INFO - 'config_files': ('talos/linux_config.py',), 07:26:48 INFO - 'default_actions': ('clobber', 07:26:48 INFO - 'read-buildbot-config', 07:26:48 INFO - 'download-and-extract', 07:26:48 INFO - 'populate-webroot', 07:26:48 INFO - 'create-virtualenv', 07:26:48 INFO - 'install', 07:26:48 INFO - 'run-tests'), 07:26:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:26:48 INFO - 'download_minidump_stackwalk': True, 07:26:48 INFO - 'download_symbols': 'ondemand', 07:26:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:26:48 INFO - 'tooltool.py': '/tools/tooltool.py', 07:26:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:26:48 INFO - '/tools/misc-python/virtualenv.py')}, 07:26:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:26:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:26:48 INFO - 'installer_path': 'installer.exe', 07:26:48 INFO - 'log_level': 'info', 07:26:48 INFO - 'log_name': 'talos', 07:26:48 INFO - 'log_to_console': True, 07:26:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:26:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:26:48 INFO - 'opt_config_files': (), 07:26:48 INFO - 'pip_index': False, 07:26:48 INFO - 'sps_profile': False, 07:26:48 INFO - 'sps_profile_interval': 0, 07:26:48 INFO - 'suite': 'dromaeojs-e10s', 07:26:48 INFO - 'system_bits': '32', 07:26:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:26:48 INFO - 'title': 'talos-linux64-ix-002', 07:26:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:26:48 INFO - 'use_talos_json': True, 07:26:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:26:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:26:48 INFO - 'work_dir': 'build'} 07:26:48 INFO - ##### 07:26:48 INFO - ##### Running clobber step. 07:26:48 INFO - ##### 07:26:48 INFO - Running pre-action listener: _resource_record_pre_action 07:26:48 INFO - Running main action method: clobber 07:26:48 INFO - rmtree: /builds/slave/test/build 07:26:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:26:48 INFO - Running post-action listener: _resource_record_post_action 07:26:48 INFO - ##### 07:26:48 INFO - ##### Running read-buildbot-config step. 07:26:48 INFO - ##### 07:26:48 INFO - Running pre-action listener: _resource_record_pre_action 07:26:48 INFO - Running main action method: read_buildbot_config 07:26:48 INFO - Using buildbot properties: 07:26:48 INFO - { 07:26:48 INFO - "project": "", 07:26:48 INFO - "product": "firefox", 07:26:48 INFO - "script_repo_revision": "production", 07:26:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:26:48 INFO - "repository": "", 07:26:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:26:48 INFO - "buildid": "20160408064754", 07:26:48 INFO - "pgo_build": "False", 07:26:48 INFO - "basedir": "/builds/slave/test", 07:26:48 INFO - "buildnumber": 1134, 07:26:48 INFO - "slavename": "talos-linux64-ix-002", 07:26:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:26:48 INFO - "platform": "ubuntu64_hw", 07:26:48 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:26:48 INFO - "branch": "fx-team", 07:26:48 INFO - "repo_path": "integration/fx-team", 07:26:48 INFO - "revision": "976abe6c1b315cfc94f476e6f4facfddea0f22b4", 07:26:48 INFO - "stage_platform": "linux64", 07:26:48 INFO - "builduid": "b136f7b4a417473ebae3cbe9bf6fc0c5", 07:26:48 INFO - "slavebuilddir": "test" 07:26:48 INFO - } 07:26:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:26:48 INFO - Running post-action listener: _resource_record_post_action 07:26:48 INFO - ##### 07:26:48 INFO - ##### Running download-and-extract step. 07:26:48 INFO - ##### 07:26:48 INFO - Running pre-action listener: _resource_record_pre_action 07:26:48 INFO - Running main action method: download_and_extract 07:26:48 INFO - mkdir: /builds/slave/test/build/tests 07:26:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:48 INFO - https://queue.taskcluster.net/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:26:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:26:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:26:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/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 07:26:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/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 07:26:49 INFO - Downloaded 1361 bytes. 07:26:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:26:49 INFO - Using the following test package requirements: 07:26:49 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:26:49 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:26:49 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:26:49 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:49 INFO - u'jsshell-linux-x86_64.zip'], 07:26:49 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:26:49 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:26:49 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:26:49 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:26:49 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:26:49 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:26:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:26:49 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:49 INFO - https://queue.taskcluster.net/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:26:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:26:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:26:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/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 07:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/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 07:26:51 INFO - Downloaded 22186272 bytes. 07:26:51 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'] 07:26:51 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 07:26:52 INFO - Return code: 0 07:26:52 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 07:26: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')]} 07:26:52 INFO - https://queue.taskcluster.net/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:26:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:26:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:26:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/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 07:26:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/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 07:26:53 INFO - Downloaded 22186272 bytes. 07:26:53 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'] 07:26:53 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 07:26:54 INFO - Return code: 0 07:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:54 INFO - https://queue.taskcluster.net/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:26:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:26:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:26:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/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 07:26:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/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 07:26:55 INFO - Downloaded 10847693 bytes. 07:26:55 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'] 07:26:55 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 07:26:56 INFO - Return code: 0 07:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:56 INFO - https://queue.taskcluster.net/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:26:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:26:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:26:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/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 07:26:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e0gHHs3wSyuar1mAqMwTlg/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 07:26:58 INFO - Downloaded 54053374 bytes. 07:26:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:26:58 INFO - mkdir: /builds/slave/test/properties 07:26:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:26:58 INFO - Writing to file /builds/slave/test/properties/build_url 07:26:58 INFO - Contents: 07:26:58 INFO - build_url:https://queue.taskcluster.net/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:26:58 INFO - Running post-action listener: _resource_record_post_action 07:26:58 INFO - Running post-action listener: set_extra_try_arguments 07:26:58 INFO - ##### 07:26:58 INFO - ##### Running populate-webroot step. 07:26:58 INFO - ##### 07:26:58 INFO - Running pre-action listener: _resource_record_pre_action 07:26:58 INFO - Running main action method: populate_webroot 07:26:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:26:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:26:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:26:58 INFO - '--tppagecycles', 07:26:58 INFO - '7'], 07:26:58 INFO - 'tests': ['tsvgm']}}, 07:26:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:26:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:26:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:26:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:26:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:26:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:26:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:58 INFO - 'talos_options': ['--disable-e10s'], 07:26:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:26:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:26:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:58 INFO - 'talos_options': ['--disable-e10s'], 07:26:58 INFO - 'tests': ['damp', 'tps']}, 07:26:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:58 INFO - 'tests': ['damp', 'tps']}, 07:26:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:26:58 INFO - 'tests': ['dromaeo_dom']}, 07:26:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:26:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:26:58 INFO - 'tests': ['a11yr', 07:26:58 INFO - 'ts_paint', 07:26:58 INFO - 'tpaint', 07:26:58 INFO - 'sessionrestore', 07:26:58 INFO - 'sessionrestore_no_auto_restore', 07:26:58 INFO - 'tabpaint']}, 07:26:58 INFO - 'other-e10s': {'tests': ['a11yr', 07:26:58 INFO - 'ts_paint', 07:26:58 INFO - 'tpaint', 07:26:58 INFO - 'sessionrestore', 07:26:58 INFO - 'sessionrestore_no_auto_restore', 07:26:58 INFO - 'tabpaint']}, 07:26:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:26:58 INFO - 'ts_paint', 07:26:58 INFO - 'tpaint', 07:26:58 INFO - 'sessionrestore', 07:26:58 INFO - 'sessionrestore_no_auto_restore', 07:26:58 INFO - 'tabpaint']}, 07:26:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:26:58 INFO - 'ts_paint', 07:26:58 INFO - 'tpaint', 07:26:58 INFO - 'sessionrestore', 07:26:58 INFO - 'sessionrestore_no_auto_restore', 07:26:58 INFO - 'tabpaint']}, 07:26:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:26:58 INFO - 'tests': ['a11yr', 07:26:58 INFO - 'ts_paint', 07:26:58 INFO - 'tpaint', 07:26:58 INFO - 'sessionrestore', 07:26:58 INFO - 'sessionrestore_no_auto_restore', 07:26:58 INFO - 'tabpaint']}, 07:26:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:26:58 INFO - 'tests': ['a11yr', 07:26:58 INFO - 'ts_paint', 07:26:58 INFO - 'tpaint', 07:26:58 INFO - 'sessionrestore', 07:26:58 INFO - 'sessionrestore_no_auto_restore', 07:26:58 INFO - 'tabpaint']}, 07:26:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:26:58 INFO - 'tests': ['tsvgx', 07:26:58 INFO - 'tsvgr_opacity', 07:26:58 INFO - 'tart', 07:26:58 INFO - 'tscrollx', 07:26:58 INFO - 'cart']}, 07:26:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:26:58 INFO - 'tsvgr_opacity', 07:26:58 INFO - 'tart', 07:26:58 INFO - 'tscrollx', 07:26:58 INFO - 'cart']}, 07:26:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:58 INFO - 'talos_options': ['--disable-e10s'], 07:26:58 INFO - 'tests': ['tp5o']}, 07:26:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:58 INFO - 'tests': ['tp5o']}, 07:26:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:58 INFO - 'talos_options': ['--disable-e10s', 07:26:58 INFO - '--xperf_path', 07:26:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:26:58 INFO - 'tests': ['tp5n']}, 07:26:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:26:58 INFO - 'talos_options': ['--xperf_path', 07:26:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:26:58 INFO - 'tests': ['tp5n']}}, 07:26:58 INFO - 'talos.zip': {'path': '', 07:26:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:26:58 INFO - Running post-action listener: _resource_record_post_action 07:26:58 INFO - ##### 07:26:58 INFO - ##### Running create-virtualenv step. 07:26:58 INFO - ##### 07:26:58 INFO - Running pre-action listener: _resource_record_pre_action 07:26:58 INFO - Running main action method: create_virtualenv 07:26:58 INFO - Creating virtualenv /builds/slave/test/build/venv 07:26:58 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 07:26:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:26:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:26:58 INFO - Using real prefix '/usr' 07:26:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:26:59 INFO - Installing distribute.............................................................................................................................................................................................done. 07:27:01 INFO - Installing pip.................done. 07:27:01 INFO - Return code: 0 07:27:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd569cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2410>, '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 0x1ec3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec37a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', '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 07:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:27:01 INFO - Using env: {'DISPLAY': ':0', 07:27:01 INFO - 'HOME': '/home/cltbld', 07:27:01 INFO - 'LANG': 'en_US.UTF-8', 07:27:01 INFO - 'LANGUAGE': 'en_US:en', 07:27:01 INFO - 'LOGNAME': 'cltbld', 07:27:01 INFO - 'MAIL': '/var/mail/cltbld', 07:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:01 INFO - 'MOZ_NO_REMOTE': '1', 07:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:01 INFO - 'NO_EM_RESTART': '1', 07:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:01 INFO - 'PWD': '/builds/slave/test', 07:27:01 INFO - 'SHELL': '/bin/bash', 07:27:01 INFO - 'SHLVL': '1', 07:27:01 INFO - 'TERM': 'linux', 07:27:01 INFO - 'TMOUT': '86400', 07:27:01 INFO - 'USER': 'cltbld', 07:27:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', 07:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:01 INFO - '_': '/tools/buildbot/bin/python'} 07:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:01 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 07:27:01 INFO - Cleaning up... 07:27:01 INFO - Return code: 0 07:27:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd569cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2410>, '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 0x1ec3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec37a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', '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 07:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:27:01 INFO - Using env: {'DISPLAY': ':0', 07:27:01 INFO - 'HOME': '/home/cltbld', 07:27:01 INFO - 'LANG': 'en_US.UTF-8', 07:27:01 INFO - 'LANGUAGE': 'en_US:en', 07:27:01 INFO - 'LOGNAME': 'cltbld', 07:27:01 INFO - 'MAIL': '/var/mail/cltbld', 07:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:01 INFO - 'MOZ_NO_REMOTE': '1', 07:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:01 INFO - 'NO_EM_RESTART': '1', 07:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:01 INFO - 'PWD': '/builds/slave/test', 07:27:01 INFO - 'SHELL': '/bin/bash', 07:27:01 INFO - 'SHLVL': '1', 07:27:01 INFO - 'TERM': 'linux', 07:27:01 INFO - 'TMOUT': '86400', 07:27:01 INFO - 'USER': 'cltbld', 07:27:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', 07:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:01 INFO - '_': '/tools/buildbot/bin/python'} 07:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:01 INFO - Downloading/unpacking psutil>=0.7.1 07:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:27:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:03 INFO - Installing collected packages: psutil 07:27:03 INFO - Running setup.py install for psutil 07:27:03 INFO - building 'psutil._psutil_linux' extension 07:27:03 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 07:27:04 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 07:27:04 INFO - building 'psutil._psutil_posix' extension 07:27:04 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 07:27:04 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 07:27:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:04 INFO - Successfully installed psutil 07:27:04 INFO - Cleaning up... 07:27:04 INFO - Return code: 0 07:27:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:27:04 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')]} 07:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:04 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')]} 07:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:04 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 0x7fd569cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2410>, '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 0x1ec3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec37a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', '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 07:27:04 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 07:27:04 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 07:27:04 INFO - Using env: {'DISPLAY': ':0', 07:27:04 INFO - 'HOME': '/home/cltbld', 07:27:04 INFO - 'LANG': 'en_US.UTF-8', 07:27:04 INFO - 'LANGUAGE': 'en_US:en', 07:27:04 INFO - 'LOGNAME': 'cltbld', 07:27:04 INFO - 'MAIL': '/var/mail/cltbld', 07:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:04 INFO - 'MOZ_NO_REMOTE': '1', 07:27:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:04 INFO - 'NO_EM_RESTART': '1', 07:27:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:04 INFO - 'PWD': '/builds/slave/test', 07:27:04 INFO - 'SHELL': '/bin/bash', 07:27:04 INFO - 'SHLVL': '1', 07:27:04 INFO - 'TERM': 'linux', 07:27:04 INFO - 'TMOUT': '86400', 07:27:04 INFO - 'USER': 'cltbld', 07:27:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', 07:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:04 INFO - '_': '/tools/buildbot/bin/python'} 07:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:27:06 INFO - Installing collected packages: mozsystemmonitor 07:27:06 INFO - Running setup.py install for mozsystemmonitor 07:27:06 INFO - Successfully installed mozsystemmonitor 07:27:06 INFO - Cleaning up... 07:27:06 INFO - Return code: 0 07:27:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:27:06 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')]} 07:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:06 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')]} 07:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:06 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 0x7fd569cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2410>, '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 0x1ec3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec37a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', '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 07:27:06 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 07:27:06 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 07:27:06 INFO - Using env: {'DISPLAY': ':0', 07:27:06 INFO - 'HOME': '/home/cltbld', 07:27:06 INFO - 'LANG': 'en_US.UTF-8', 07:27:06 INFO - 'LANGUAGE': 'en_US:en', 07:27:06 INFO - 'LOGNAME': 'cltbld', 07:27:06 INFO - 'MAIL': '/var/mail/cltbld', 07:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:06 INFO - 'MOZ_NO_REMOTE': '1', 07:27:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:06 INFO - 'NO_EM_RESTART': '1', 07:27:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:06 INFO - 'PWD': '/builds/slave/test', 07:27:06 INFO - 'SHELL': '/bin/bash', 07:27:06 INFO - 'SHLVL': '1', 07:27:06 INFO - 'TERM': 'linux', 07:27:06 INFO - 'TMOUT': '86400', 07:27:06 INFO - 'USER': 'cltbld', 07:27:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', 07:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:06 INFO - '_': '/tools/buildbot/bin/python'} 07:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:06 INFO - Downloading/unpacking blobuploader==1.2.4 07:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:08 INFO - Downloading blobuploader-1.2.4.tar.gz 07:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:27:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:27:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:27:09 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 07:27:09 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 07:27:09 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 07:27:09 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 07:27:09 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 07:27:09 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 07:27:09 INFO - Downloading docopt-0.6.1.tar.gz 07:27:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:27:09 INFO - Installing collected packages: blobuploader, requests, docopt 07:27:09 INFO - Running setup.py install for blobuploader 07:27:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:27:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:27:09 INFO - Running setup.py install for requests 07:27:09 INFO - Running setup.py install for docopt 07:27:10 INFO - Successfully installed blobuploader requests docopt 07:27:10 INFO - Cleaning up... 07:27:10 INFO - Return code: 0 07:27:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27:10 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')]} 07:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:10 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')]} 07:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:10 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 0x7fd569cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2410>, '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 0x1ec3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec37a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', '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 07:27:10 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 07:27:10 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 07:27:10 INFO - Using env: {'DISPLAY': ':0', 07:27:10 INFO - 'HOME': '/home/cltbld', 07:27:10 INFO - 'LANG': 'en_US.UTF-8', 07:27:10 INFO - 'LANGUAGE': 'en_US:en', 07:27:10 INFO - 'LOGNAME': 'cltbld', 07:27:10 INFO - 'MAIL': '/var/mail/cltbld', 07:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:10 INFO - 'MOZ_NO_REMOTE': '1', 07:27:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:10 INFO - 'NO_EM_RESTART': '1', 07:27:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:10 INFO - 'PWD': '/builds/slave/test', 07:27:10 INFO - 'SHELL': '/bin/bash', 07:27:10 INFO - 'SHLVL': '1', 07:27:10 INFO - 'TERM': 'linux', 07:27:10 INFO - 'TMOUT': '86400', 07:27:10 INFO - 'USER': 'cltbld', 07:27:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', 07:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:10 INFO - '_': '/tools/buildbot/bin/python'} 07:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:27:10 INFO - Running setup.py (path:/tmp/pip-5dQmKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:27:10 INFO - Running setup.py (path:/tmp/pip-ApcCzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:27:10 INFO - Running setup.py (path:/tmp/pip-VXeCkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:27:10 INFO - Running setup.py (path:/tmp/pip-oR8TpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:27:10 INFO - Running setup.py (path:/tmp/pip-Ogg2zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:27:10 INFO - Running setup.py (path:/tmp/pip-HwJfWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:27:10 INFO - Running setup.py (path:/tmp/pip-w6ShYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:27:10 INFO - Running setup.py (path:/tmp/pip-g1XFDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:27:10 INFO - Running setup.py (path:/tmp/pip-3R8cjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:27:11 INFO - Running setup.py (path:/tmp/pip-KNdSUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:27:11 INFO - Running setup.py (path:/tmp/pip-bbzLs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:27:11 INFO - Running setup.py (path:/tmp/pip-RihKWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:27:11 INFO - Running setup.py (path:/tmp/pip-oB_i2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:27:11 INFO - Running setup.py (path:/tmp/pip-4SHkry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:11 INFO - Running setup.py (path:/tmp/pip-Z6og5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:27:11 INFO - Running setup.py (path:/tmp/pip-bVLHvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:27:11 INFO - Running setup.py (path:/tmp/pip-Ls4IHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:27:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:27:11 INFO - Running setup.py install for manifestparser 07:27:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:27:11 INFO - Running setup.py install for mozcrash 07:27:11 INFO - Running setup.py install for mozdebug 07:27:11 INFO - Running setup.py install for mozdevice 07:27:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:27:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:27:12 INFO - Running setup.py install for mozfile 07:27:12 INFO - Running setup.py install for mozhttpd 07:27:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:27:12 INFO - Running setup.py install for mozinfo 07:27:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:27:12 INFO - Running setup.py install for mozInstall 07:27:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:27:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:27:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:27:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:27:12 INFO - Running setup.py install for mozleak 07:27:12 INFO - Running setup.py install for mozlog 07:27:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:27:12 INFO - Running setup.py install for moznetwork 07:27:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:27:12 INFO - Running setup.py install for mozprocess 07:27:12 INFO - Running setup.py install for mozprofile 07:27:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:27:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:27:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:27:12 INFO - Running setup.py install for mozrunner 07:27:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:27:13 INFO - Running setup.py install for mozscreenshot 07:27:13 INFO - Running setup.py install for moztest 07:27:13 INFO - Running setup.py install for mozversion 07:27:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:27:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:27:13 INFO - Cleaning up... 07:27:13 INFO - Return code: 0 07:27:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27:13 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')]} 07:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:13 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')]} 07:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:13 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 0x7fd569cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2410>, '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 0x1ec3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec37a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', '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 07:27:13 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 07:27:13 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 07:27:13 INFO - Using env: {'DISPLAY': ':0', 07:27:13 INFO - 'HOME': '/home/cltbld', 07:27:13 INFO - 'LANG': 'en_US.UTF-8', 07:27:13 INFO - 'LANGUAGE': 'en_US:en', 07:27:13 INFO - 'LOGNAME': 'cltbld', 07:27:13 INFO - 'MAIL': '/var/mail/cltbld', 07:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:13 INFO - 'MOZ_NO_REMOTE': '1', 07:27:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:13 INFO - 'NO_EM_RESTART': '1', 07:27:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:13 INFO - 'PWD': '/builds/slave/test', 07:27:13 INFO - 'SHELL': '/bin/bash', 07:27:13 INFO - 'SHLVL': '1', 07:27:13 INFO - 'TERM': 'linux', 07:27:13 INFO - 'TMOUT': '86400', 07:27:13 INFO - 'USER': 'cltbld', 07:27:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', 07:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:13 INFO - '_': '/tools/buildbot/bin/python'} 07:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:27:13 INFO - Running setup.py (path:/tmp/pip-LsapDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:27:13 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)) 07:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:27:13 INFO - Running setup.py (path:/tmp/pip-mBH5A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:27:13 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)) 07:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:27:13 INFO - Running setup.py (path:/tmp/pip-w7Z_S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:27:13 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)) 07:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:27:13 INFO - Running setup.py (path:/tmp/pip-K9T_6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:27:13 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)) 07:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:27:13 INFO - Running setup.py (path:/tmp/pip-cL_zA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:27:13 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)) 07:27:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:27:13 INFO - Running setup.py (path:/tmp/pip-PTeUOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:27:14 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)) 07:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:27:14 INFO - Running setup.py (path:/tmp/pip-1WIbsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:27:14 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)) 07:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:27:14 INFO - Running setup.py (path:/tmp/pip-JM5j0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:27:14 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)) 07:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:27:14 INFO - Running setup.py (path:/tmp/pip-2koPOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:27:14 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)) 07:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:27:14 INFO - Running setup.py (path:/tmp/pip-HbmueU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:27:14 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)) 07:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:27:14 INFO - Running setup.py (path:/tmp/pip-HXiKJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:27:14 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)) 07:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:27:14 INFO - Running setup.py (path:/tmp/pip-vmCe6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:27:14 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)) 07:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:27:14 INFO - Running setup.py (path:/tmp/pip-2XgIO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:27:14 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)) 07:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:27:14 INFO - Running setup.py (path:/tmp/pip-FHcyVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:27:14 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)) 07:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:14 INFO - Running setup.py (path:/tmp/pip-H3Mf37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:14 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)) 07:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:27:14 INFO - Running setup.py (path:/tmp/pip-r9Zl2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:27:14 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)) 07:27:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:27:14 INFO - Running setup.py (path:/tmp/pip-wxnbtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:27:14 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)) 07:27:14 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)) 07:27:14 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)) 07:27:14 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)) 07:27:14 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)) 07:27:14 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)) 07:27:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:16 INFO - Downloading blessings-1.6.tar.gz 07:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:27:16 INFO - Installing collected packages: blessings 07:27:16 INFO - Running setup.py install for blessings 07:27:16 INFO - Successfully installed blessings 07:27:16 INFO - Cleaning up... 07:27:16 INFO - Return code: 0 07:27:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:27:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:27:17 INFO - Reading from file tmpfile_stdout 07:27:17 INFO - Current package versions: 07:27:17 INFO - argparse == 1.2.1 07:27:17 INFO - blessings == 1.6 07:27:17 INFO - blobuploader == 1.2.4 07:27:17 INFO - docopt == 0.6.1 07:27:17 INFO - manifestparser == 1.1 07:27:17 INFO - mozInstall == 1.12 07:27:17 INFO - mozcrash == 0.17 07:27:17 INFO - mozdebug == 0.1 07:27:17 INFO - mozdevice == 0.48 07:27:17 INFO - mozfile == 1.2 07:27:17 INFO - mozhttpd == 0.7 07:27:17 INFO - mozinfo == 0.9 07:27:17 INFO - mozleak == 0.1 07:27:17 INFO - mozlog == 3.1 07:27:17 INFO - moznetwork == 0.27 07:27:17 INFO - mozprocess == 0.22 07:27:17 INFO - mozprofile == 0.28 07:27:17 INFO - mozrunner == 6.11 07:27:17 INFO - mozscreenshot == 0.1 07:27:17 INFO - mozsystemmonitor == 0.0 07:27:17 INFO - moztest == 0.7 07:27:17 INFO - mozversion == 1.4 07:27:17 INFO - psutil == 3.1.1 07:27:17 INFO - requests == 1.2.3 07:27:17 INFO - wsgiref == 0.1.2 07:27:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:17 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 0x7fd569cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2410>, '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 0x1ec3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec37a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', '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 07:27:17 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 07:27:17 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 07:27:17 INFO - Using env: {'DISPLAY': ':0', 07:27:17 INFO - 'HOME': '/home/cltbld', 07:27:17 INFO - 'LANG': 'en_US.UTF-8', 07:27:17 INFO - 'LANGUAGE': 'en_US:en', 07:27:17 INFO - 'LOGNAME': 'cltbld', 07:27:17 INFO - 'MAIL': '/var/mail/cltbld', 07:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:17 INFO - 'MOZ_NO_REMOTE': '1', 07:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:17 INFO - 'NO_EM_RESTART': '1', 07:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:17 INFO - 'PWD': '/builds/slave/test', 07:27:17 INFO - 'SHELL': '/bin/bash', 07:27:17 INFO - 'SHLVL': '1', 07:27:17 INFO - 'TERM': 'linux', 07:27:17 INFO - 'TMOUT': '86400', 07:27:17 INFO - 'USER': 'cltbld', 07:27:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', 07:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:17 INFO - '_': '/tools/buildbot/bin/python'} 07:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:17 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)) 07:27:17 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)) 07:27:17 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)) 07:27:17 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)) 07:27:17 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)) 07:27:17 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)) 07:27:17 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)) 07:27:17 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)) 07:27:17 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)) 07:27:17 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)) 07:27:17 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)) 07:27:17 INFO - Cleaning up... 07:27:17 INFO - Return code: 0 07:27:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:17 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 0x7fd569cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2410>, '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 0x1ec3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec37a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', '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 07:27:17 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 07:27:17 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 07:27:17 INFO - Using env: {'DISPLAY': ':0', 07:27:17 INFO - 'HOME': '/home/cltbld', 07:27:17 INFO - 'LANG': 'en_US.UTF-8', 07:27:17 INFO - 'LANGUAGE': 'en_US:en', 07:27:17 INFO - 'LOGNAME': 'cltbld', 07:27:17 INFO - 'MAIL': '/var/mail/cltbld', 07:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:17 INFO - 'MOZ_NO_REMOTE': '1', 07:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:17 INFO - 'NO_EM_RESTART': '1', 07:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:17 INFO - 'PWD': '/builds/slave/test', 07:27:17 INFO - 'SHELL': '/bin/bash', 07:27:17 INFO - 'SHLVL': '1', 07:27:17 INFO - 'TERM': 'linux', 07:27:17 INFO - 'TMOUT': '86400', 07:27:17 INFO - 'USER': 'cltbld', 07:27:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', 07:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:17 INFO - '_': '/tools/buildbot/bin/python'} 07:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:17 INFO - Downloading/unpacking jsonschema 07:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:27:19 INFO - Downloading/unpacking functools32 (from jsonschema) 07:27:19 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 07:27:19 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 07:27:19 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 07:27:19 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 07:27:19 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 07:27:19 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 07:27:19 INFO - Downloading functools32-3.2.3-2.tar.gz 07:27:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:27:19 INFO - warning: no files found matching '*.txt' 07:27:19 INFO - no previously-included directories found matching 'build' 07:27:19 INFO - no previously-included directories found matching 'dist' 07:27:19 INFO - no previously-included directories found matching '.git*' 07:27:19 INFO - Installing collected packages: jsonschema, functools32 07:27:19 INFO - Running setup.py install for functools32 07:27:19 INFO - warning: no files found matching '*.txt' 07:27:19 INFO - no previously-included directories found matching 'build' 07:27:19 INFO - no previously-included directories found matching 'dist' 07:27:19 INFO - no previously-included directories found matching '.git*' 07:27:19 INFO - Successfully installed jsonschema functools32 07:27:19 INFO - Cleaning up... 07:27:19 INFO - Return code: 0 07:27:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:19 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 0x7fd569cc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e335a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec2410>, '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 0x1ec3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec37a0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', '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 07:27:19 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 07:27:19 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 07:27:19 INFO - Using env: {'DISPLAY': ':0', 07:27:19 INFO - 'HOME': '/home/cltbld', 07:27:19 INFO - 'LANG': 'en_US.UTF-8', 07:27:19 INFO - 'LANGUAGE': 'en_US:en', 07:27:19 INFO - 'LOGNAME': 'cltbld', 07:27:19 INFO - 'MAIL': '/var/mail/cltbld', 07:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:19 INFO - 'MOZ_NO_REMOTE': '1', 07:27:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:19 INFO - 'NO_EM_RESTART': '1', 07:27:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:19 INFO - 'PWD': '/builds/slave/test', 07:27:19 INFO - 'SHELL': '/bin/bash', 07:27:19 INFO - 'SHLVL': '1', 07:27:19 INFO - 'TERM': 'linux', 07:27:19 INFO - 'TMOUT': '86400', 07:27:19 INFO - 'USER': 'cltbld', 07:27:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', 07:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:19 INFO - '_': '/tools/buildbot/bin/python'} 07:27:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:20 INFO - Downloading/unpacking flake8 07:27:20 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 07:27:20 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 07:27:20 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 07:27:20 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 07:27:20 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 07:27:20 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 07:27:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:27:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:27:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:27:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:27:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:27:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:27:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:27:22 INFO - no previously-included directories found matching 'docs/_build' 07:27:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:27:22 INFO - Running setup.py install for pep8 07:27:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:27:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:27:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:27:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:27:22 INFO - no previously-included directories found matching 'docs/_build' 07:27:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:27:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:27:22 INFO - Cleaning up... 07:27:23 INFO - Return code: 0 07:27:23 INFO - Running post-action listener: _resource_record_post_action 07:27:23 INFO - Running post-action listener: _start_resource_monitoring 07:27:23 INFO - Starting resource monitoring. 07:27:23 INFO - ##### 07:27:23 INFO - ##### Running install step. 07:27:23 INFO - ##### 07:27:23 INFO - Running pre-action listener: _resource_record_pre_action 07:27:23 INFO - Running main action method: install 07:27:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:27:23 INFO - Reading from file tmpfile_stdout 07:27:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:27:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:27:23 INFO - Reading from file tmpfile_stdout 07:27:23 INFO - Output received: 07:27:23 INFO - Usage: mozinstall [options] installer 07:27:23 INFO - Options: 07:27:23 INFO - -h, --help show this help message and exit 07:27:23 INFO - -d DEST, --destination=DEST 07:27:23 INFO - Directory to install application into. [default: 07:27:23 INFO - "/builds/slave/test"] 07:27:23 INFO - --app=APP Application being installed. [default: firefox] 07:27:23 INFO - mkdir: /builds/slave/test/build/application 07:27:23 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'] 07:27:23 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 07:27:38 INFO - Reading from file tmpfile_stdout 07:27:38 INFO - Output received: 07:27:38 INFO - /builds/slave/test/build/application/firefox/firefox 07:27:38 INFO - Running post-action listener: _resource_record_post_action 07:27:38 INFO - ##### 07:27:38 INFO - ##### Running run-tests step. 07:27:38 INFO - ##### 07:27:38 INFO - Running pre-action listener: _resource_record_pre_action 07:27:38 INFO - Running main action method: run_tests 07:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:27:38 INFO - Python 2.7.3 07:27:38 INFO - Return code: 0 07:27:38 INFO - grabbing minidump binary from tooltool 07:27: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')]} 07:27:38 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 0x1ec2410>, '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 0x1ec3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:27:38 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 07:27:38 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 07:27:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:27:38 INFO - Return code: 0 07:27:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:27:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:27:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:27:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:27:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:27:39 INFO - Return code: 0 07:27:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 07:27:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 07:27:39 INFO - Using env: {'DISPLAY': ':0', 07:27:39 INFO - 'HOME': '/home/cltbld', 07:27:39 INFO - 'LANG': 'en_US.UTF-8', 07:27:39 INFO - 'LANGUAGE': 'en_US:en', 07:27:39 INFO - 'LOGNAME': 'cltbld', 07:27:39 INFO - 'MAIL': '/var/mail/cltbld', 07:27:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:27:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:39 INFO - 'MOZ_NO_REMOTE': '1', 07:27:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:27:39 INFO - 'NO_EM_RESTART': '1', 07:27:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:39 INFO - 'PWD': '/builds/slave/test', 07:27:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:27:39 INFO - 'SHELL': '/bin/bash', 07:27:39 INFO - 'SHLVL': '1', 07:27:39 INFO - 'TERM': 'linux', 07:27:39 INFO - 'TMOUT': '86400', 07:27:39 INFO - 'USER': 'cltbld', 07:27:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397', 07:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:39 INFO - '_': '/tools/buildbot/bin/python'} 07:27:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 07:27:40 INFO - mozversion application_buildid: 20160408064754 07:27:40 INFO - mozversion application_changeset: 976abe6c1b315cfc94f476e6f4facfddea0f22b4 07:27:40 INFO - mozversion application_display_name: Nightly 07:27:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:27:40 INFO - mozversion application_name: Firefox 07:27:40 INFO - mozversion application_remotingname: firefox 07:27:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:27:40 INFO - mozversion application_vendor: Mozilla 07:27:40 INFO - mozversion application_version: 48.0a1 07:27:40 INFO - mozversion platform_buildid: 20160408064754 07:27:40 INFO - mozversion platform_changeset: 976abe6c1b315cfc94f476e6f4facfddea0f22b4 07:27:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:27:40 INFO - mozversion platform_version: 48.0a1 07:27:40 INFO - using testdate: 1460125660 07:27:40 INFO - actual date: 1460125660 07:27:40 INFO - starting webserver on 'localhost:58163' 07:27:40 INFO - SUITE-START | Running 2 tests 07:27:40 INFO - TEST-START | dromaeo_css 07:27:40 INFO - operating with platform_type : linux_ 07:27:40 INFO - Initialising browser for dromaeo_css test... 07:27:40 INFO - TEST-INFO | started process 22912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsCFSZO/profile http://localhost:58163/getInfo.html) 07:27:43 INFO - PROCESS | 22912 | 07:27:43 INFO - PROCESS | 22912 | (process:22977): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:27:44 INFO - PROCESS | 22912 | 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] 07:27:44 INFO - PROCESS | 22912 | __metrics Screen width/height:1600/1200 07:27:44 INFO - PROCESS | 22912 | colorDepth:24 07:27:44 INFO - PROCESS | 22912 | Browser inner width/height: 1024/697 07:27:44 INFO - PROCESS | 22912 | __metrics 07:27:45 ERROR - PROCESS | 22912 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 07:27:46 INFO - TEST-INFO | 22912: exit 0 07:27:46 INFO - Browser initialized. 07:27:46 INFO - Running cycle 1/1 for dromaeo_css test... 07:27:46 INFO - TEST-INFO | started process 23028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsCFSZO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:27:48 INFO - PROCESS | 23028 | 07:27:48 INFO - PROCESS | 23028 | (process:23088): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:27:58 INFO - PROCESS | 23028 | RSS: Main: 163995648 07:27:58 INFO - PROCESS | 23028 | 07:28:47 INFO - PROCESS | 23028 | 1460125727910 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] 07:30:59 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:58163/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58163/tests/dromaeo/cssquery-ext.html) 07:31:00 INFO - PROCESS | 23028 | RSS: Main: 169295872 07:31:00 INFO - PROCESS | 23028 | 07:34:02 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:58163/tests/dromaeo/cssquery-ext.html (next: http://localhost:58163/tests/dromaeo/cssquery-jquery.html) 07:34:03 INFO - PROCESS | 23028 | RSS: Main: 165150720 07:34:03 INFO - PROCESS | 23028 | 07:37:05 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:58163/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58163/tests/dromaeo/cssquery-mootools.html) 07:37:05 INFO - PROCESS | 23028 | RSS: Main: 166002688 07:37:05 INFO - PROCESS | 23028 | 07:40:07 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:58163/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58163/tests/dromaeo/cssquery-prototype.html) 07:40:08 INFO - PROCESS | 23028 | RSS: Main: 164081664 07:40:08 INFO - PROCESS | 23028 | 07:43:10 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:58163/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58163/tests/dromaeo/cssquery-yui.html) 07:43:11 INFO - PROCESS | 23028 | RSS: Main: 165531648 07:43:11 INFO - PROCESS | 23028 | 07:46:13 INFO - PROCESS | 23028 | Cycle 1(1): loaded http://localhost:58163/tests/dromaeo/cssquery-yui.html (next: http://localhost:58163/tests/dromaeo/cssquery-dojo.html) 07:46:14 INFO - PROCESS | 23028 | RSS: Main: 167858176 07:46:14 INFO - PROCESS | 23028 | 07:46:14 INFO - PROCESS | 23028 | __start_tp_report 07:46:14 INFO - PROCESS | 23028 | _x_x_mozilla_page_load 07:46:14 INFO - PROCESS | 23028 | _x_x_mozilla_page_load_details 07:46:14 INFO - PROCESS | 23028 | |i|pagename|runs| 07:46:14 INFO - PROCESS | 23028 | |0;dojo.html;2627.6058591211317;2678.3304173956517;2715.2125883493786;2716.049382716051;2740.9451810963783;4643.1410189114995;4663.044075964428;4681.39141911551;4698.27176787598;4731.503192164825;4594.839180628679;4733.550312720295;4801.807927682898;4818.951810481894;4844.249141383082;4326.675499337554;4403.801828917691;4412.691111622188;4457.754823484707;4539.251023581105;4365.738055716652;4395.450568678915;4419.646428285745;4432.8005239764125;4486.237339652267;4346.760928148935;4389;4391.8682439526865;4409.118176364708;4438.090191510732;4407.140607581523;4411.647068234533;4423.690341676084;4425.070735145623;4478.798454069574;4247.554006829269;4321.114171594815;4363.083752411997;4369.781510924473;4391.758453285068;4526;4557.680962332638;4583.954160458419;4585.977070114662;4593.770311484446;4917.483664215278;4946.282788995612;4950.975245123751;4959.950400495985;4977.7511124444;4931.112399768041;4980.9252861207115;5033.723145227011;5079.390473143209;5133.537981581676;4767.189577771787;4794.376731024944;4796.544328288772;4824.541668541483;4840.636952228597;5246.291750613618;5250.789968401221;5250.921236181461;5251.658642188246;5258.763355649005;4805.303231031481;4993.425756038029;5014;5033.219850923113;5099.898002040012;4916.06594746997;5021.14640511114;5069.746512674352;5091.210862316347;5142.588592912558;5042.117629414838;5069.31564238823;5070;5071.41678706946;5112.514311140436;4834.927476087862;4982;5028.974855125701;5057.494250574913;5069.03688299222;4388.166248412791;4390.626796722315;4403.801828917706;4409.823607055682;4442.133783912171;3812.5806161322234;3825.2731980923536;3831.7700937943814;3864.4589757433982;3864.729468937204;4318.481782186158;4427.424434823452;4488.5511448855505;4515.164694531522;4519.502854685982;5168.664036837594;5171.818986335536;5182.170852663556;5182.300389447451;5210.088234559013;4345.739255644671;4481.775911204492;4483.193025255486;4484.12559550891;4536;4699.483056863743;4730.172219861511;4736.786844591933;4749.4063242094735;4784.952150478521;4778.976105119452;4832.492588278251;4839.249916262985;4839.903201936012;4913.336699545587;4951;5085.059264036166;5085.288059671575;5108.463611320758;5172.172452407747;4730.810767569259;4743.217369134054;4749.596284315872;4776.379070720784;4784.067106914118;4886.731229782254;4918.704877707349;4924.433690125681;4928.630352723489;4990.80036798524;4947.579455746302;4995.475475075064;5087.771050302671;5098.923516147187;5163.870903227449;4800.4479484859685;4848.781804818721;4900.191468407673;4969.204927211629;5029.723365214948;4923.926141107958;4967.925481117858;4972.129877271535;4973.179425394914;5037.0681423936685;4679.742614156254;4818.542238487338;4904.754762261944;4906.901861962812;4917.557419832232;4979.676321039121;4998.350214472095;5000.2999580058095;5025.3718285214345;5084.618653600921;4851.151048566416;4907.214845624683;4916.778744956414;4917.311576379238;4918.040982008474 07:46:14 INFO - PROCESS | 23028 | |1;ext.html;562.5780664501624;594.1473984831765;600.3486217454063;612.5161122713057;629.5467263570231;33314.16714582137;34522;34600.65399346006;34605.82697086511;34731;36370.63629363706;36886;37304.813475932584;37480.062998425055;37524.81237593808;7472.738454154106;7637.465377423582;7685.346745526637;7689.8077548061465;7697.884531732;7577.886331705001;7640.656170472342;7704.730334438295;7749.418793590475;7830.491018083806;7800.843983120334;7802.258785415376;7825.100113486965;7838.843223135534;7839.764807055797;7816.921830781676;7831.725889593866;7847.725329613465;7860.29257366834;7882.014748156481;7731;7865.449418540705;7866.410019248579;7878.684852605889;7895.842083158304;37834.43248351277;38212.61787382146;38343.616563834286;38360.80819595884;38525.229495409934;3023.349979754363;3145.779795414322;3156.878551737176;3162.826044567548;3229.821115292925;27740.861295693394;28251.43497130046;28272.15183544497;28399.148025559265;28410.573841392397;3529.364714351416;3566.4472006838982;3589.4436362363876;3641.7814931104217;3694.5935947045805;229656;230899;231283;231422;232786;32873.17817054545;33610.495842562384;33681.49477757836;51359.48640513622;51829.7408512955;32116;32275.838620807215;32299.838500807346;32437.837810811267;32503.349933001682;12595;12622.81065784014;12644.747105057848;12650.304233267074;12759;9719.805603887882;9751.561179746786;9760.755981100529;9819;9835.901640983499;8022.237887400687;8062;8072.717454889168;8080.111187769341;8184.508929464251;3162.1462205204466;3211.935761284761;3247.431699452586;3249.1227368610344;3285.2608163163095;933.610992098691;945.9810803783886;1009.8838633557089;1017.31839667423;1019.23557332001;28227.294317641812;28694.282642934093;28909.710902890703;29081.85459072691;29221.269468263465;981.1709105805583;1016.6136867990265;1033.302520798473;1037.3464717228098;1080.308602494404;14359.497417590543;14956;15017.624559386102;15164.696706065817;15259.160746159068;334322;335696;337034;339673;341398;47654.046919061424;48051;48529;48781.5121848777;48870;1242.9937850310691;1253.529926277646;1282.249883817977;1286.1897004887048;1287.1247551664771;26405.33986650349;27812.44375112527;27857.44285114327;28159.43681126407;28270;41995.16009679851;42688;42689.5731042698;42741;42836;299649;301106;301931;302402;302841;24945.625815612417;25001.624975625746;25121.371965701004;25354.746452535237;25672.101476448235;41792.74621761352;42335;42488.78755606202;42603.5739642612;43142.35286470642;35717.1070723234;35798.46302305415;35963.10092247715;36471.45292820663;36950.63049369472;35895.64104358923;36035.45946810852;36193.095172620895;36435.635643643225;36748.81625591855;32005.35989280248;37157.81421092877;39055;40144.795656130365;40341.19317613573;29520;30115.247118822204;30844.537331940486;30865.69134308628;31015.379692406477;24197;24765.25704228876;24811.875940620183;24818.379540511633;24899.128530501344 07:46:14 INFO - PROCESS | 23028 | |2;jquery.html;364.34054361605496;367.1115899523154;374.78075325934327;385.5566098986164;385.9208862183253;15896.20518974051;16417.34330626775;16676.58308542284;16705.749413758804;16945.745813812802;15795.210239488008;16809.32762689494;17007.23467443965;17074.23165957532;17130.486085417426;5023.899522009567;5227.163653815391;5271.262023316739;5271.4464981177;5290.206469029637;3763.322601931651;5164.096283150452;5723.341815691208;6015.398460153971;6046.244219472566;5999;6005.459508644221;6022.126791615213;6026.216591843055;6033.818985430444;5838.2994040715175;6089.269287685462;6095.725692343811;6099.054646529773;6104.633721976696;5109.795608175668;5298.81454149103;5302.045631786277;5307.230451584499;5414.702191379472;20015.1993920243;20046.79953200464;20297;20338.694919576217;20418;1931.0730849192325;1998.430447322506;2020.8888511131881;2320.709911261092;2336.3224664847176;13075.649693851014;13181.077324587282;13218.339083045808;13283.468661253539;13678.31608419575;1683.225716170563;1689.5860514173983;1718.5617667494835;1752.6845167869778;1788.1863751992812;65890;67614.66192669005;68055.65972170107;68191;69173.96239056418;8928.776780580407;8989.966153892256;9215.926416556355;9317.767055823659;9459.290553208537;12369.257844529357;12511;12512.81230781539;12529.248245105322;12541.498340066295;7084.716611335592;7098.0062791209275;7155.17715462718;7178.425725941912;7220.566765994057;6998.090248267795;7029.31122118464;7085.89371159433;7108.218096009435;7137.678804453812;5917.201177840936;5968.46283834457;6020.819375418744;6058.242719660043;6090;1510.297711564128;1672.3143511160365;1703.8466538011392;1710.0936503652836;1755.2101554300361;892.4288455388556;901.7745563609097;909.7998440343114;954.8472244440856;966.8791401074866;15794.60513487149;15807.525774226791;16070.276837542338;16284.26720797567;17069.7439538407;861.1087524412203;880.6125304865839;882.7131182365757;888.5024386343669;928.6471140966524;8514.787130321667;8715.912840871637;8724.78188045304;8788.648454061893;8905.510196939102;365374;369228;389213;410134.2905996552;417479;75986.62006690042;76523.61738191273;78679;79365.20634793694;80842.59578702069;1000.9249306302056;1003.5333569890037;1013.9898601013896;1015.4009134610468;1027.1525991057408;13907.096038757449;13913.652158696113;14129.788053179005;14163.504277350243;14306.713865722419;30625;31275.218119546284;31446.842765786023;31902.52146217855;32740.345193095527;43062;45402.772986134856;45623.54376456193;49297;49313.50686493233;7307.9634601828775;7525.134609519756;7585.16563178061;7636.236376362319;7684;10744.247902646739;11034.337939723642;11481.540738370706;11606.071514279007;11659.941700291783;10136.239782016526;10464.267501274837;10611.522481488506;10722.142228621535;10737.08734757523;10065.496725163859;10201.183905287708;10326.690199294033;10341.896581034394;10498.527566259383;10563.788724225626;10622.150227981589;10719.517621707198;10932.781344373227;10964.451777411257;7290.343869051599;7354.96322518384;7386.298301661333;7410.851782964418;8216.876746848682;8994.370394072352;10575.841362379417;10670.62652807179;10796.730081747704;10832.945835270773 07:46:14 INFO - PROCESS | 23028 | |3;mootools.html;1403.621022323973;1463.948761793337;1575.9677411295597;1762.4095927864164;1811.52900245936;6811.318868113186;7559.244075592438;7598.31615154636;7849.646765895534;7860.489068210562;7700.614969251543;7744.341730952876;7781.9221807781905;7797.25926037027;7828.178041305652;2197.7362716474004;2215.6233440315186;2218.6228341182036;2220.6335954567476;2222.411061068818;2131.8081372676456;2175.140819376353;2178.4880553070016;2189.2228258968075;2190.3319487556287;2172.7392712874475;2204.272590045281;2207.4371035386034;2237.9776202238013;2283.303592404316;2205.0628482894704;2227.9554408911895;2228.8551244169157;2230.35319757271;2238.149503188786;2163.123934806406;2201.1745595401726;2206.58074965756;2206.6579680149603;2212.3805334506364;7859.842803143905;7971.083325417535;7978.481398709066;7979.122296547375;7987.480813747146;4517.751523666197;4609.1933911565675;4625.306204069417;4631.560001799824;4634.513376095495;2862.5265209026675;3014.1861697341815;3018.9245268868235;3033.272014716474;3047.7866549341556;928.1414691410419;933.1741408853146;943.8725772020827;953.5232383808096;958.6548842416724;10465.79068418635;10528.263021588491;10536.683899483029;10571.260011799177;10580.470976451224;4057.431959525669;4139.172165566899;4264.488261408589;4308.569143085729;4322.027543802619;9073.13805188506;9084.18242358191;9092.363534552518;9093.545322733837;9097.1812536872;4503.932441013388;4514.277715565494;4520.163769702615;4523.072770082125;4532.954670453253;3740.925181496355;4049.838006479708;4116.835326586963;4138.985948442651;4206.453161089039;3767.3783825669007;3807;3847.442120892455;3905.902352441155;3907.2185562886966;1256.5036810459817;1271.465984286602;1276.3937129863427;1280.5262053040435;1302.947882084706;983.7442265011149;1003.8343673293971;1016.0855230292648;1070.6252811516063;1239.7024714068739;7383.228490762318;7419.406447484296;7426.962865185747;7475.850482990419;7477.775666730006;421.061033894411;426.3604593110334;427.4016377072124;428.9335153051282;429.0946103721146;5710.143478478261;5729.885402292014;5937.584369094122;5951.732172052268;5958.791442299499;9350;9656.37233579815;9688.224942004623;9734.172595329477;9763.804723905625;9104.772380690536;9375.343725939256;9464.242860571137;9700.078492543196;9735.367201131903;7173.282671732785;7236.7828965130075;7272;7301.744438944717;7309.122905251297;7243.239459856639;7427.665755041145;7484.438667100098;7528.134264559427;7532.585707786125;8535.53054582004;8659.52372619512;8728.56357182151;8949.552522373986;8965.50689712072;8848.867266990872;8966.596503157243;9125.224355929555;9201.585928633094;9216.308776841897;6174.320824709368;6457.741690332334;6680.966595167188;6887.276835932155;7037.366637002694;7554.773356799305;7563;7568.735094271894;7599.354054905395;7644.388448924184;6698.66506674674;6744.0895479109695;6932.029515867682;6978.302169782981;7033.226345102137;6694.799156025327;6744.730210791709;6753.932460675331;6815.420689241271;6832.282610326043;6800;7074.71701131949;7135.8572828544175;7167.641617919187;7262.455315851226;6653.900191497035;6685.866282674417;6729.528932974645;6745.898811517733;6781.254062053072;6648.700808463727;6710.127683401127;6714.026466162281;6723.596584204964;6726.058351830649 07:46:14 INFO - PROCESS | 23028 | |4;prototype.html;312.5062401405779;317.2797749109523;319.476059262809;321.3877563242025;329.6258746322923;5242.239875218091;5260.342457192851;5339.679619222849;5351.892962140755;5369.355677318717;5251.133562962106;5263.710495922723;5274.156135018397;5281.155015197569;5281.498257665516;3851.114243723945;3975.9204815903663;4123.690723195772;4134.4831896013;4155.31437312843;4068.8575899843513;4112.3625837995005;4134.56587058359;4144.254034273829;4150.626443620074;4108.589141085882;4111.876643700693;4117.929338372015;4121.629053385194;4134.441850350195;4025.879223623281;4071.9389209161886;4117.341225403921;4127.566605506424;4144;3622.510961020255;3631.3282042821897;3635.654612811779;3636.127329440915;3649.1789347396625;5022.447530771612;5037.596992240612;5048.343715317022;5055.469175736568;5063;4666.836660716858;4717.764111794397;4752.453467851206;4754.714717116949;4777.402824646919;5547.583931205136;5578.107502799573;5582.581306402036;5582.972085139589;5604.8318550443555;3929.2141571685493;3985.740926839746;4006.419069234974;4016.9397459038137;4020.9396859047138;5599.916001259984;5693.487586117228;5766.558360409897;5838.095095260242;5842.649441033552;4102.097538541516;4105.178964207171;4118.5263694674895;4121.793910304473;4135.731177473514;4126.442930204444;4157.147784704189;4162.4796900387455;4173.979130104391;4180.602842729936;4730.787114579852;4731.7634118293945;4744.976275118603;4745.1695953208055;4754.144254034307;5333;5589.385167631557;5608.327000759853;5638.830835074954;5639;1367.6170672211797;1386.2791348498724;1395.8185435893472;1396.4902810474105;1397.1756663568544;879.2131042716733;911.3119594705954;935.4948327902856;972.0862389353985;972.2562239886493;4804.471508134103;4835.782389792397;4860.513948605182;4868.707877527359;4882.121218180761;5650.802221922213;5687.497501099503;5691.886162276731;5722.942770572325;5725.713714314267;4682.601978831769;4859.2954021666665;4871.658983871095;4874.122657921537;4957.206846904478;3067;3088.9536656950163;3106.51848963411;3109.7667674924473;3113.735332496763;5490.423505531941;5504.2018907258225;5505.623594101475;5520.641158324696;5521.033819081645;5841.182234487175;5876.206712093898;5939.575016612651;5988.7423641035;5993.220881285405;5490.80782172622;5492.093804522209;5501.367342755634;5502.064649009598;5504.7522861470525;5651.660900345828;5705.771769129188;5736.827895163152;5798.94201057984;5800.100984347433;5706.258186435737;5732.824770921868;5749.281339832521;5758.3090029196765;5770.163326317576;5491.807786727445;5492.725363731877;5495.6153069286365;5499.2576002240785;5520.337559492887;3782.2813665403487;4005.9599404006754;4013;4029.979850100731;4056.3104272274372;5780.5953583248765;5789.855253618524;5802.65184088956;5806.883862322815;5807.767689292381;5608.747606357642;5618.353889302783;5623.156526521055;5636.1827535008015;5646.85882852932;5458.890822183614;5544.279243698294;5561.694106824163;5588.441155884541;5597.5499477914345;5216.252555393986;5496.148097044965;5502.312210973629;5516.806911758069;5530.5022547970875;5439.864003399946;5642.852503410072;5656.236408084856;5685;5695.658260504218;5507.0637991542335;5533;5546.084895992116;5548.583856210881;5553.750081246434 07:46:14 INFO - PROCESS | 23028 | |5;yui.html;630.5743623054437;643.9162908821852;676.0265218085956;730.5434103685199;735.9916913828056;11677.824832627506;11746.53013879446;11822.940885295582;11827.645170644873;11869.703257418558;12460.376981150928;12826.61520154397;12953.805692914613;13027.413766380512;13094.73810523789;650.9576877502947;799.6601444386142;811.6144831205189;815.0545367373848;817.5830326533481;803.04036676172;807.422692774666;810.6716779704229;812.995935020327;816.2123550773503;857.3398483167957;859.475719810918;864.3474176996359;864.9827003459927;866.8136350684601;856.7772379181396;857.7598272483715;863.1023735315265;863.6113748813028;863.952482613456;626.2516293029831;626.7023163997065;627.8963970944789;628.6196850905228;629.0250112325876;12661.620151395473;12721.87278127216;12728.299943503103;12732.87267127326;12775.48898044077;12815.359232038361;12825.486980520767;12848.743025139538;13020.934895325463;13171.60485185446;9907.603695852158;10023.74940626483;10199.898001020043;10351.430671313075;10365.118964887919;3329.500574913758;3403.744719146049;3421.4525675891737;3447.7414193935306;3460.0657822387816;42045;44181.55818441806;44556.55443445557;50042.7497862512;50057;9266.768330791649;9287.953560232156;9339.392939458914;9363.204127649089;9369.953150234205;16829.915850420915;16872.66254674924;16876.324947001984;16877.240524176443;16970.830291696926;6570.145881035531;6768.458523318122;6843;6911;7018.227994920555;3737.383331750231;3773.735838491279;3906.5898080701686;3908.5895980922164;3918.9608103918595;2793.7485626293733;2869.92825179368;2874.453853767777;2879.7840161987515;2890.7976441648884;501.36827597227756;506.2431664661355;509.5057793939872;510.0971280832905;518.3184112891536;594.3877805859971;595.8986972214734;631.36232405271;638.553012890969;652.5758257132807;7617.961910190414;7751;7789.961050194826;7932.286094251545;7948.602569871483;461.92378257587796;503.9823606173766;582.7644206985275;606.7845914700218;620.5532016947881;3568.553930758655;3680.5031320771354;3710.350688629479;3742.8128593570214;3752.5121734174927;41949.79025104855;47311;47387.526124739;51031.234531482056;51772;42262.788686056985;42512.78743606262;43487;43871.78064109659;44317.89205269894;38788.64239751595;39581.802090989935;40031.39952900709;40157.79921100376;40633.1873362537;7525.285097915689;7710.653020614198;7713.92286077132;7779.883301750365;7869.606519674108;28973.710262897945;29040.12879613615;29090.12729618115;29613.555796662637;29730.256743581584;37245.6275437253;38009.23981520409;38142.046448839;38369;38536.6146338533;10667.168868756913;10733.409662468326;10769.246152769545;10819.621313253998;11045.613403530839;11631.302121872715;11794.882051179378;11963.102767292661;12120.75758484843;12487.750244994868;10928.836067458835;11107.666769996913;11472.082233421139;11676.474558644712;11696.181267311207;10795.946020269848;10934.890651093387;11082.501287442246;11342.20604557673;11388.259763115371;10849.620263290746;10854.67435976922;10866.239363244496;11075.667729968114;11172.162087843282;9465.574049167943;9537.52312384392;9610.423374597547;9665.613375464902;9894;9535.427874327563;9620.37467564606;9775.902240977499;9779.706608801747;9904.405735655884 07:46:14 INFO - PROCESS | 23028 | __end_tp_report 07:46:14 INFO - PROCESS | 23028 | __start_cc_report 07:46:14 INFO - PROCESS | 23028 | _x_x_mozilla_cycle_collect,367 07:46:14 INFO - PROCESS | 23028 | __end_cc_report 07:46:14 INFO - PROCESS | 23028 | __startTimestamp1460126774205__endTimestamp 07:46:14 INFO - PROCESS | 23028 | 07:46:14 INFO - PROCESS | 23028 | ------- Summary: start ------- 07:46:14 INFO - PROCESS | 23028 | Number of tests: 6 07:46:14 INFO - PROCESS | 23028 | 07:46:14 INFO - PROCESS | 23028 | [#0] dojo.html Cycles:165 Average:4705.09 Median:4824.54 stddev:472.05 (9.8%) stddev-sans-first:444.48 07:46:14 INFO - PROCESS | 23028 | Values: 2627.6 2678.3 2715.2 2716.0 2740.9 4643.1 4663.0 4681.4 4698.3 4731.5 4594.8 4733.6 4801.8 4819.0 4844.2 4326.7 4403.8 4412.7 4457.8 4539.3 4365.7 4395.5 4419.6 4432.8 4486.2 4346.8 4389.0 4391.9 4409.1 4438.1 4407.1 4411.6 4423.7 4425.1 4478.8 4247.6 4321.1 4363.1 4369.8 4391.8 4526.0 4557.7 4584.0 4586.0 4593.8 4917.5 4946.3 4951.0 4960.0 4977.8 4931.1 4980.9 5033.7 5079.4 5133.5 4767.2 4794.4 4796.5 4824.5 4840.6 5246.3 5250.8 5250.9 5251.7 5258.8 4805.3 4993.4 5014.0 5033.2 5099.9 4916.1 5021.1 5069.7 5091.2 5142.6 5042.1 5069.3 5070.0 5071.4 5112.5 4834.9 4982.0 5029.0 5057.5 5069.0 4388.2 4390.6 4403.8 4409.8 4442.1 3812.6 3825.3 3831.8 3864.5 3864.7 4318.5 4427.4 4488.6 4515.2 4519.5 5168.7 5171.8 5182.2 5182.3 5210.1 4345.7 4481.8 4483.2 4484.1 4536.0 4699.5 4730.2 4736.8 4749.4 4785.0 4779.0 4832.5 4839.2 4839.9 4913.3 4951.0 5085.1 5085.3 5108.5 5172.2 4730.8 4743.2 4749.6 4776.4 4784.1 4886.7 4918.7 4924.4 4928.6 4990.8 4947.6 4995.5 5087.8 5098.9 5163.9 4800.4 4848.8 4900.2 4969.2 5029.7 4923.9 4967.9 4972.1 4973.2 5037.1 4679.7 4818.5 4904.8 4906.9 4917.6 4979.7 4998.4 5000.3 5025.4 5084.6 4851.2 4907.2 4916.8 4917.3 4918.0 07:46:14 INFO - PROCESS | 23028 | 07:46:14 INFO - PROCESS | 23028 | [#1] ext.html Cycles:180 Average:43335.57 Median:19130.18 stddev:77148.07 (403.3%) stddev-sans-first:77297.65 07:46:14 INFO - PROCESS | 23028 | Values: 562.6 594.1 600.3 612.5 629.5 33314.2 34522.0 34600.7 34605.8 34731.0 36370.6 36886.0 37304.8 37480.1 37524.8 7472.7 7637.5 7685.3 7689.8 7697.9 7577.9 7640.7 7704.7 7749.4 7830.5 7800.8 7802.3 7825.1 7838.8 7839.8 7816.9 7831.7 7847.7 7860.3 7882.0 7731.0 7865.4 7866.4 7878.7 7895.8 37834.4 38212.6 38343.6 38360.8 38525.2 3023.3 3145.8 3156.9 3162.8 3229.8 27740.9 28251.4 28272.2 28399.1 28410.6 3529.4 3566.4 3589.4 3641.8 3694.6 229656.0 230899.0 231283.0 231422.0 232786.0 32873.2 33610.5 33681.5 51359.5 51829.7 32116.0 32275.8 32299.8 32437.8 32503.3 12595.0 12622.8 12644.7 12650.3 12759.0 9719.8 9751.6 9760.8 9819.0 9835.9 8022.2 8062.0 8072.7 8080.1 8184.5 3162.1 3211.9 3247.4 3249.1 3285.3 933.6 946.0 1009.9 1017.3 1019.2 28227.3 28694.3 28909.7 29081.9 29221.3 981.2 1016.6 1033.3 1037.3 1080.3 14359.5 14956.0 15017.6 15164.7 15259.2 334322.0 335696.0 337034.0 339673.0 341398.0 47654.0 48051.0 48529.0 48781.5 48870.0 1243.0 1253.5 1282.2 1286.2 1287.1 26405.3 27812.4 27857.4 28159.4 28270.0 41995.2 42688.0 42689.6 42741.0 42836.0 299649.0 301106.0 301931.0 302402.0 302841.0 24945.6 25001.6 25121.4 25354.7 25672.1 41792.7 42335.0 42488.8 42603.6 43142.4 35717.1 35798.5 35963.1 36471.5 36950.6 35895.6 36035.5 36193.1 36435.6 36748.8 32005.4 37157.8 39055.0 40144.8 40341.2 29520.0 30115.2 30844.5 30865.7 31015.4 24197.0 24765.3 24811.9 24818.4 24899.1 07:46:14 INFO - PROCESS | 23028 | 07:46:14 INFO - PROCESS | 23028 | [#2] jquery.html Cycles:180 Average:24088.42 Median:385.74 stddev:64444.20 (16706.7%) stddev-sans-first:64600.37 07:46:14 INFO - PROCESS | 23028 | Values: 364.3 367.1 374.8 385.6 385.9 15896.2 16417.3 16676.6 16705.7 16945.7 15795.2 16809.3 17007.2 17074.2 17130.5 5023.9 5227.2 5271.3 5271.4 5290.2 3763.3 5164.1 5723.3 6015.4 6046.2 5999.0 6005.5 6022.1 6026.2 6033.8 5838.3 6089.3 6095.7 6099.1 6104.6 5109.8 5298.8 5302.0 5307.2 5414.7 20015.2 20046.8 20297.0 20338.7 20418.0 1931.1 1998.4 2020.9 2320.7 2336.3 13075.6 13181.1 13218.3 13283.5 13678.3 1683.2 1689.6 1718.6 1752.7 1788.2 65890.0 67614.7 68055.7 68191.0 69174.0 8928.8 8990.0 9215.9 9317.8 9459.3 12369.3 12511.0 12512.8 12529.2 12541.5 7084.7 7098.0 7155.2 7178.4 7220.6 6998.1 7029.3 7085.9 7108.2 7137.7 5917.2 5968.5 6020.8 6058.2 6090.0 1510.3 1672.3 1703.8 1710.1 1755.2 892.4 901.8 909.8 954.8 966.9 15794.6 15807.5 16070.3 16284.3 17069.7 861.1 880.6 882.7 888.5 928.6 8514.8 8715.9 8724.8 8788.6 8905.5 365374.0 369228.0 389213.0 410134.3 417479.0 75986.6 76523.6 78679.0 79365.2 80842.6 1000.9 1003.5 1014.0 1015.4 1027.2 13907.1 13913.7 14129.8 14163.5 14306.7 30625.0 31275.2 31446.8 31902.5 32740.3 43062.0 45402.8 45623.5 49297.0 49313.5 7308.0 7525.1 7585.2 7636.2 7684.0 10744.2 11034.3 11481.5 11606.1 11659.9 10136.2 10464.3 10611.5 10722.1 10737.1 10065.5 10201.2 10326.7 10341.9 10498.5 10563.8 10622.2 10719.5 10932.8 10964.5 7290.3 7355.0 7386.3 7410.9 8216.9 8994.4 10575.8 10670.6 10796.7 10832.9 07:46:14 INFO - PROCESS | 23028 | 07:46:14 INFO - PROCESS | 23028 | [#3] mootools.html Cycles:180 Average:5466.89 Median:6696.73 stddev:2912.89 (43.5%) stddev-sans-first:2905.05 07:46:14 INFO - PROCESS | 23028 | Values: 1403.6 1463.9 1576.0 1762.4 1811.5 6811.3 7559.2 7598.3 7849.6 7860.5 7700.6 7744.3 7781.9 7797.3 7828.2 2197.7 2215.6 2218.6 2220.6 2222.4 2131.8 2175.1 2178.5 2189.2 2190.3 2172.7 2204.3 2207.4 2238.0 2283.3 2205.1 2228.0 2228.9 2230.4 2238.1 2163.1 2201.2 2206.6 2206.7 2212.4 7859.8 7971.1 7978.5 7979.1 7987.5 4517.8 4609.2 4625.3 4631.6 4634.5 2862.5 3014.2 3018.9 3033.3 3047.8 928.1 933.2 943.9 953.5 958.7 10465.8 10528.3 10536.7 10571.3 10580.5 4057.4 4139.2 4264.5 4308.6 4322.0 9073.1 9084.2 9092.4 9093.5 9097.2 4503.9 4514.3 4520.2 4523.1 4533.0 3740.9 4049.8 4116.8 4139.0 4206.5 3767.4 3807.0 3847.4 3905.9 3907.2 1256.5 1271.5 1276.4 1280.5 1302.9 983.7 1003.8 1016.1 1070.6 1239.7 7383.2 7419.4 7427.0 7475.9 7477.8 421.1 426.4 427.4 428.9 429.1 5710.1 5729.9 5937.6 5951.7 5958.8 9350.0 9656.4 9688.2 9734.2 9763.8 9104.8 9375.3 9464.2 9700.1 9735.4 7173.3 7236.8 7272.0 7301.7 7309.1 7243.2 7427.7 7484.4 7528.1 7532.6 8535.5 8659.5 8728.6 8949.6 8965.5 8848.9 8966.6 9125.2 9201.6 9216.3 6174.3 6457.7 6681.0 6887.3 7037.4 7554.8 7563.0 7568.7 7599.4 7644.4 6698.7 6744.1 6932.0 6978.3 7033.2 6694.8 6744.7 6753.9 6815.4 6832.3 6800.0 7074.7 7135.9 7167.6 7262.5 6653.9 6685.9 6729.5 6745.9 6781.3 6648.7 6710.1 6714.0 6723.6 6726.1 07:46:14 INFO - PROCESS | 23028 | 07:46:14 INFO - PROCESS | 23028 | [#4] prototype.html Cycles:180 Average:4636.11 Median:5277.66 stddev:1358.69 (25.7%) stddev-sans-first:1323.18 07:46:14 INFO - PROCESS | 23028 | Values: 312.5 317.3 319.5 321.4 329.6 5242.2 5260.3 5339.7 5351.9 5369.4 5251.1 5263.7 5274.2 5281.2 5281.5 3851.1 3975.9 4123.7 4134.5 4155.3 4068.9 4112.4 4134.6 4144.3 4150.6 4108.6 4111.9 4117.9 4121.6 4134.4 4025.9 4071.9 4117.3 4127.6 4144.0 3622.5 3631.3 3635.7 3636.1 3649.2 5022.4 5037.6 5048.3 5055.5 5063.0 4666.8 4717.8 4752.5 4754.7 4777.4 5547.6 5578.1 5582.6 5583.0 5604.8 3929.2 3985.7 4006.4 4016.9 4020.9 5599.9 5693.5 5766.6 5838.1 5842.6 4102.1 4105.2 4118.5 4121.8 4135.7 4126.4 4157.1 4162.5 4174.0 4180.6 4730.8 4731.8 4745.0 4745.2 4754.1 5333.0 5589.4 5608.3 5638.8 5639.0 1367.6 1386.3 1395.8 1396.5 1397.2 879.2 911.3 935.5 972.1 972.3 4804.5 4835.8 4860.5 4868.7 4882.1 5650.8 5687.5 5691.9 5722.9 5725.7 4682.6 4859.3 4871.7 4874.1 4957.2 3067.0 3089.0 3106.5 3109.8 3113.7 5490.4 5504.2 5505.6 5520.6 5521.0 5841.2 5876.2 5939.6 5988.7 5993.2 5490.8 5492.1 5501.4 5502.1 5504.8 5651.7 5705.8 5736.8 5798.9 5800.1 5706.3 5732.8 5749.3 5758.3 5770.2 5491.8 5492.7 5495.6 5499.3 5520.3 3782.3 4006.0 4013.0 4030.0 4056.3 5780.6 5789.9 5802.7 5806.9 5807.8 5608.7 5618.4 5623.2 5636.2 5646.9 5458.9 5544.3 5561.7 5588.4 5597.5 5216.3 5496.1 5502.3 5516.8 5530.5 5439.9 5642.9 5656.2 5685.0 5695.7 5507.1 5533.0 5546.1 5548.6 5553.8 07:46:14 INFO - PROCESS | 23028 | 07:46:14 INFO - PROCESS | 23028 | [#5] yui.html Cycles:180 Average:12481.56 Median:42153.89 stddev:13741.67 (32.6%) stddev-sans-first:13751.40 07:46:14 INFO - PROCESS | 23028 | Values: 630.6 643.9 676.0 730.5 736.0 11677.8 11746.5 11822.9 11827.6 11869.7 12460.4 12826.6 12953.8 13027.4 13094.7 651.0 799.7 811.6 815.1 817.6 803.0 807.4 810.7 813.0 816.2 857.3 859.5 864.3 865.0 866.8 856.8 857.8 863.1 863.6 864.0 626.3 626.7 627.9 628.6 629.0 12661.6 12721.9 12728.3 12732.9 12775.5 12815.4 12825.5 12848.7 13020.9 13171.6 9907.6 10023.7 10199.9 10351.4 10365.1 3329.5 3403.7 3421.5 3447.7 3460.1 42045.0 44181.6 44556.6 50042.7 50057.0 9266.8 9288.0 9339.4 9363.2 9370.0 16829.9 16872.7 16876.3 16877.2 16970.8 6570.1 6768.5 6843.0 6911.0 7018.2 3737.4 3773.7 3906.6 3908.6 3919.0 2793.7 2869.9 2874.5 2879.8 2890.8 501.4 506.2 509.5 510.1 518.3 594.4 595.9 631.4 638.6 652.6 7618.0 7751.0 7790.0 7932.3 7948.6 461.9 504.0 582.8 606.8 620.6 3568.6 3680.5 3710.4 3742.8 3752.5 41949.8 47311.0 47387.5 51031.2 51772.0 42262.8 42512.8 43487.0 43871.8 44317.9 38788.6 39581.8 40031.4 40157.8 40633.2 7525.3 7710.7 7713.9 7779.9 7869.6 28973.7 29040.1 29090.1 29613.6 29730.3 37245.6 38009.2 38142.0 38369.0 38536.6 10667.2 10733.4 10769.2 10819.6 11045.6 11631.3 11794.9 11963.1 12120.8 12487.8 10928.8 11107.7 11472.1 11676.5 11696.2 10795.9 10934.9 11082.5 11342.2 11388.3 10849.6 10854.7 10866.2 11075.7 11172.2 9465.6 9537.5 9610.4 9665.6 9894.0 9535.4 9620.4 9775.9 9779.7 9904.4 07:46:14 INFO - PROCESS | 23028 | -------- Summary: end -------- 07:46:14 INFO - PROCESS | 23028 | 07:46:14 INFO - TEST-INFO | 23028: exit 0 07:46:14 INFO - TEST-OK | dromaeo_css | took 1114769ms 07:46:14 INFO - TEST-START | kraken 07:46:14 INFO - operating with platform_type : linux_ 07:46:14 INFO - Initialising browser for kraken test... 07:46:14 INFO - TEST-INFO | started process 23302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6ygWz1/profile http://localhost:58163/getInfo.html) 07:46:18 INFO - PROCESS | 23302 | 07:46:18 INFO - PROCESS | 23302 | (process:23367): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:46:18 INFO - PROCESS | 23302 | 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] 07:46:19 INFO - PROCESS | 23302 | __metrics Screen width/height:1600/1200 07:46:19 INFO - PROCESS | 23302 | colorDepth:24 07:46:19 INFO - PROCESS | 23302 | Browser inner width/height: 1024/697 07:46:19 INFO - PROCESS | 23302 | __metrics 07:46:20 ERROR - PROCESS | 23302 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 07:46:21 INFO - TEST-INFO | 23302: exit 0 07:46:21 INFO - Browser initialized. 07:46:21 INFO - Running cycle 1/1 for kraken test... 07:46:21 INFO - TEST-INFO | started process 23418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6ygWz1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:46:22 INFO - PROCESS | 23418 | 07:46:22 INFO - PROCESS | 23418 | (process:23476): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:46:32 INFO - PROCESS | 23418 | RSS: Main: 164667392 07:46:32 INFO - PROCESS | 23418 | 07:46:35 INFO - PROCESS | 23418 | Cycle 1(1): loaded http://localhost:58163/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58163/tests/kraken/driver.html?testName=audio-beat-detection) 07:46:36 INFO - PROCESS | 23418 | RSS: Main: 168996864 07:46:36 INFO - PROCESS | 23418 | 07:46:39 INFO - PROCESS | 23418 | Cycle 1(1): loaded http://localhost:58163/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58163/tests/kraken/driver.html?testName=audio-dft) 07:46:39 INFO - PROCESS | 23418 | RSS: Main: 172507136 07:46:39 INFO - PROCESS | 23418 | 07:46:42 INFO - PROCESS | 23418 | Cycle 1(1): loaded http://localhost:58163/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58163/tests/kraken/driver.html?testName=audio-fft) 07:46:43 INFO - PROCESS | 23418 | RSS: Main: 163287040 07:46:43 INFO - PROCESS | 23418 | 07:46:45 INFO - PROCESS | 23418 | Cycle 1(1): loaded http://localhost:58163/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58163/tests/kraken/driver.html?testName=audio-oscillator) 07:46:45 INFO - PROCESS | 23418 | RSS: Main: 163893248 07:46:45 INFO - PROCESS | 23418 | 07:46:48 INFO - PROCESS | 23418 | Cycle 1(1): loaded http://localhost:58163/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58163/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:46:48 INFO - PROCESS | 23418 | RSS: Main: 164356096 07:46:48 INFO - PROCESS | 23418 | 07:46:52 INFO - PROCESS | 23418 | Cycle 1(1): loaded http://localhost:58163/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58163/tests/kraken/driver.html?testName=imaging-darkroom) 07:46:52 INFO - PROCESS | 23418 | RSS: Main: 165064704 07:46:52 INFO - PROCESS | 23418 | 07:46:56 INFO - PROCESS | 23418 | Cycle 1(1): loaded http://localhost:58163/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58163/tests/kraken/driver.html?testName=imaging-desaturate) 07:46:56 INFO - PROCESS | 23418 | RSS: Main: 164376576 07:46:56 INFO - PROCESS | 23418 | 07:46:59 INFO - PROCESS | 23418 | Cycle 1(1): loaded http://localhost:58163/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58163/tests/kraken/driver.html?testName=json-parse-financial) 07:47:00 INFO - PROCESS | 23418 | RSS: Main: 164618240 07:47:00 INFO - PROCESS | 23418 | 07:47:02 INFO - PROCESS | 23418 | Cycle 1(1): loaded http://localhost:58163/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58163/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:47:02 INFO - PROCESS | 23418 | RSS: Main: 165031936 07:47:02 INFO - PROCESS | 23418 | 07:47:04 INFO - PROCESS | 23418 | Cycle 1(1): loaded http://localhost:58163/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58163/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:47:05 INFO - PROCESS | 23418 | RSS: Main: 165335040 07:47:05 INFO - PROCESS | 23418 | 07:47:07 INFO - PROCESS | 23418 | Cycle 1(1): loaded http://localhost:58163/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58163/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:47:07 INFO - PROCESS | 23418 | RSS: Main: 165695488 07:47:07 INFO - PROCESS | 23418 | 07:47:10 INFO - PROCESS | 23418 | Cycle 1(1): loaded http://localhost:58163/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:47:11 INFO - PROCESS | 23418 | RSS: Main: 165744640 07:47:11 INFO - PROCESS | 23418 | 07:47:14 INFO - PROCESS | 23418 | Cycle 1(1): loaded http://localhost:58163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:47:14 INFO - PROCESS | 23418 | RSS: Main: 165683200 07:47:14 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | Cycle 1(1): loaded http://localhost:58163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58163/tests/kraken/driver.html?testName=ai-astar) 07:47:16 INFO - PROCESS | 23418 | RSS: Main: 167301120 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | __start_tp_report 07:47:16 INFO - PROCESS | 23418 | _x_x_mozilla_page_load 07:47:16 INFO - PROCESS | 23418 | _x_x_mozilla_page_load_details 07:47:16 INFO - PROCESS | 23418 | |i|pagename|runs| 07:47:16 INFO - PROCESS | 23418 | |0;ai-astar;116;108;114;114;115;126;113;115;113;114 07:47:16 INFO - PROCESS | 23418 | |1;audio-beat-detection;164;132;157;173;135;157;166;136;189;133 07:47:16 INFO - PROCESS | 23418 | |2;audio-dft;161;163;163;163;164;167;168;163;166;162 07:47:16 INFO - PROCESS | 23418 | |3;audio-fft;74;74;79;75;73;73;76;144;75;74 07:47:16 INFO - PROCESS | 23418 | |4;audio-oscillator;94;95;147;93;94;93;139;94;95;138 07:47:16 INFO - PROCESS | 23418 | |5;imaging-gaussian-blur;117;118;117;117;117;118;118;118;118;117 07:47:16 INFO - PROCESS | 23418 | |6;imaging-darkroom;148;146;147;147;149;149;147;150;148;147 07:47:16 INFO - PROCESS | 23418 | |7;imaging-desaturate;96;96;97;95;96;96;96;96;95;96 07:47:16 INFO - PROCESS | 23418 | |8;json-parse-financial;66;67;68;66;66;66;68;65;68;64 07:47:16 INFO - PROCESS | 23418 | |9;json-stringify-tinderbox;64;65;64;64;67;67;64;64;64;65 07:47:16 INFO - PROCESS | 23418 | |10;stanford-crypto-aes;86;86;89;86;85;84;87;86;86;86 07:47:16 INFO - PROCESS | 23418 | |11;stanford-crypto-ccm;140;150;145;136;144;155;143;142;144;144 07:47:16 INFO - PROCESS | 23418 | |12;stanford-crypto-pbkdf2;177;170;179;172;172;173;176;169;171;170 07:47:16 INFO - PROCESS | 23418 | |13;stanford-crypto-sha256-iterative;72;71;71;72;73;80;74;72;72;77 07:47:16 INFO - PROCESS | 23418 | __end_tp_report 07:47:16 INFO - PROCESS | 23418 | __start_cc_report 07:47:16 INFO - PROCESS | 23418 | _x_x_mozilla_cycle_collect,913 07:47:16 INFO - PROCESS | 23418 | __end_cc_report 07:47:16 INFO - PROCESS | 23418 | __startTimestamp1460126836951__endTimestamp 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | ------- Summary: start ------- 07:47:16 INFO - PROCESS | 23418 | Number of tests: 14 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | [#0] ai-astar Cycles:10 Average:114.80 Median:114.50 stddev:4.49 (3.9%) stddev-sans-first:4.74 07:47:16 INFO - PROCESS | 23418 | Values: 116.0 108.0 114.0 114.0 115.0 126.0 113.0 115.0 113.0 114.0 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | [#1] audio-beat-detection Cycles:10 Average:154.20 Median:160.50 stddev:19.60 (12.2%) stddev-sans-first:20.47 07:47:16 INFO - PROCESS | 23418 | Values: 164.0 132.0 157.0 173.0 135.0 157.0 166.0 136.0 189.0 133.0 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:2.26 (1.4%) stddev-sans-first:2.12 07:47:16 INFO - PROCESS | 23418 | Values: 161.0 163.0 163.0 163.0 164.0 167.0 168.0 163.0 166.0 162.0 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | [#3] audio-fft Cycles:10 Average:81.70 Median:74.50 stddev:21.96 (29.5%) stddev-sans-first:23.11 07:47:16 INFO - PROCESS | 23418 | Values: 74.0 74.0 79.0 75.0 73.0 73.0 76.0 144.0 75.0 74.0 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:94.00 stddev:22.99 (24.5%) stddev-sans-first:23.81 07:47:16 INFO - PROCESS | 23418 | Values: 94.0 95.0 147.0 93.0 94.0 93.0 139.0 94.0 95.0 138.0 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:47:16 INFO - PROCESS | 23418 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 07:47:16 INFO - PROCESS | 23418 | Values: 148.0 146.0 147.0 147.0 149.0 149.0 147.0 150.0 148.0 147.0 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:47:16 INFO - PROCESS | 23418 | Values: 96.0 96.0 97.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:66.50 stddev:1.35 (2.0%) stddev-sans-first:1.42 07:47:16 INFO - PROCESS | 23418 | Values: 66.0 67.0 68.0 66.0 66.0 66.0 68.0 65.0 68.0 64.0 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:64.50 stddev:1.23 (1.9%) stddev-sans-first:1.27 07:47:16 INFO - PROCESS | 23418 | Values: 64.0 65.0 64.0 64.0 67.0 67.0 64.0 64.0 64.0 65.0 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:1.29 (1.5%) stddev-sans-first:1.36 07:47:16 INFO - PROCESS | 23418 | Values: 86.0 86.0 89.0 86.0 85.0 84.0 87.0 86.0 86.0 86.0 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:144.00 stddev:5.19 (3.6%) stddev-sans-first:5.26 07:47:16 INFO - PROCESS | 23418 | Values: 140.0 150.0 145.0 136.0 144.0 155.0 143.0 142.0 144.0 144.0 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:172.50 stddev:3.35 (1.9%) stddev-sans-first:3.21 07:47:16 INFO - PROCESS | 23418 | Values: 177.0 170.0 179.0 172.0 172.0 173.0 176.0 169.0 171.0 170.0 07:47:16 INFO - PROCESS | 23418 | 07:47:16 INFO - PROCESS | 23418 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:72.50 stddev:2.91 (4.0%) stddev-sans-first:3.05 07:47:16 INFO - PROCESS | 23418 | Values: 72.0 71.0 71.0 72.0 73.0 80.0 74.0 72.0 72.0 77.0 07:47:16 INFO - PROCESS | 23418 | -------- Summary: end -------- 07:47:16 INFO - PROCESS | 23418 | 07:47:17 INFO - TEST-INFO | 23418: exit 0 07:47:17 INFO - TEST-OK | kraken | took 63020ms 07:47:17 INFO - SUITE-END | took 1177s 07:47:18 INFO - Completed test suite (00:19:37) 07:47:18 INFO - javascript benchmark 07:47:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2627.6058591211317, 2678.3304173956517, 2715.2125883493786, 2716.049382716051, 2740.9451810963783, 4643.1410189114995, 4663.044075964428, 4681.39141911551, 4698.27176787598, 4731.503192164825, 4594.839180628679, 4733.550312720295, 4801.807927682898, 4818.951810481894, 4844.249141383082, 4326.675499337554, 4403.801828917691, 4412.691111622188, 4457.754823484707, 4539.251023581105, 4365.738055716652, 4395.450568678915, 4419.646428285745, 4432.8005239764125, 4486.237339652267, 4346.760928148935, 4389.0, 4391.8682439526865, 4409.118176364708, 4438.090191510732, 4407.140607581523, 4411.647068234533, 4423.690341676084, 4425.070735145623, 4478.798454069574, 4247.554006829269, 4321.114171594815, 4363.083752411997, 4369.781510924473, 4391.758453285068, 4526.0, 4557.680962332638, 4583.954160458419, 4585.977070114662, 4593.770311484446, 4917.483664215278, 4946.282788995612, 4950.975245123751, 4959.950400495985, 4977.7511124444, 4931.112399768041, 4980.9252861207115, 5033.723145227011, 5079.390473143209, 5133.537981581676, 4767.189577771787, 4794.376731024944, 4796.544328288772, 4824.541668541483, 4840.636952228597, 5246.291750613618, 5250.789968401221, 5250.921236181461, 5251.658642188246, 5258.763355649005, 4805.303231031481, 4993.425756038029, 5014.0, 5033.219850923113, 5099.898002040012, 4916.06594746997, 5021.14640511114, 5069.746512674352, 5091.210862316347, 5142.588592912558, 5042.117629414838, 5069.31564238823, 5070.0, 5071.41678706946, 5112.514311140436, 4834.927476087862, 4982.0, 5028.974855125701, 5057.494250574913, 5069.03688299222, 4388.166248412791, 4390.626796722315, 4403.801828917706, 4409.823607055682, 4442.133783912171, 3812.5806161322234, 3825.2731980923536, 3831.7700937943814, 3864.4589757433982, 3864.729468937204, 4318.481782186158, 4427.424434823452, 4488.5511448855505, 4515.164694531522, 4519.502854685982, 5168.664036837594, 5171.818986335536, 5182.170852663556, 5182.300389447451, 5210.088234559013, 4345.739255644671, 4481.775911204492, 4483.193025255486, 4484.12559550891, 4536.0, 4699.483056863743, 4730.172219861511, 4736.786844591933, 4749.4063242094735, 4784.952150478521, 4778.976105119452, 4832.492588278251, 4839.249916262985, 4839.903201936012, 4913.336699545587, 4951.0, 5085.059264036166, 5085.288059671575, 5108.463611320758, 5172.172452407747, 4730.810767569259, 4743.217369134054, 4749.596284315872, 4776.379070720784, 4784.067106914118, 4886.731229782254, 4918.704877707349, 4924.433690125681, 4928.630352723489, 4990.80036798524, 4947.579455746302, 4995.475475075064, 5087.771050302671, 5098.923516147187, 5163.870903227449, 4800.4479484859685, 4848.781804818721, 4900.191468407673, 4969.204927211629, 5029.723365214948, 4923.926141107958, 4967.925481117858, 4972.129877271535, 4973.179425394914, 5037.0681423936685, 4679.742614156254, 4818.542238487338, 4904.754762261944, 4906.901861962812, 4917.557419832232, 4979.676321039121, 4998.350214472095, 5000.2999580058095, 5025.3718285214345, 5084.618653600921, 4851.151048566416, 4907.214845624683, 4916.778744956414, 4917.311576379238, 4918.040982008474], "value": 4676.26485856695, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.5780664501624, 594.1473984831765, 600.3486217454063, 612.5161122713057, 629.5467263570231, 33314.16714582137, 34522.0, 34600.65399346006, 34605.82697086511, 34731.0, 36370.63629363706, 36886.0, 37304.813475932584, 37480.062998425055, 37524.81237593808, 7472.738454154106, 7637.465377423582, 7685.346745526637, 7689.8077548061465, 7697.884531732, 7577.886331705001, 7640.656170472342, 7704.730334438295, 7749.418793590475, 7830.491018083806, 7800.843983120334, 7802.258785415376, 7825.100113486965, 7838.843223135534, 7839.764807055797, 7816.921830781676, 7831.725889593866, 7847.725329613465, 7860.29257366834, 7882.014748156481, 7731.0, 7865.449418540705, 7866.410019248579, 7878.684852605889, 7895.842083158304, 37834.43248351277, 38212.61787382146, 38343.616563834286, 38360.80819595884, 38525.229495409934, 3023.349979754363, 3145.779795414322, 3156.878551737176, 3162.826044567548, 3229.821115292925, 27740.861295693394, 28251.43497130046, 28272.15183544497, 28399.148025559265, 28410.573841392397, 3529.364714351416, 3566.4472006838982, 3589.4436362363876, 3641.7814931104217, 3694.5935947045805, 229656.0, 230899.0, 231283.0, 231422.0, 232786.0, 32873.17817054545, 33610.495842562384, 33681.49477757836, 51359.48640513622, 51829.7408512955, 32116.0, 32275.838620807215, 32299.838500807346, 32437.837810811267, 32503.349933001682, 12595.0, 12622.81065784014, 12644.747105057848, 12650.304233267074, 12759.0, 9719.805603887882, 9751.561179746786, 9760.755981100529, 9819.0, 9835.901640983499, 8022.237887400687, 8062.0, 8072.717454889168, 8080.111187769341, 8184.508929464251, 3162.1462205204466, 3211.935761284761, 3247.431699452586, 3249.1227368610344, 3285.2608163163095, 933.610992098691, 945.9810803783886, 1009.8838633557089, 1017.31839667423, 1019.23557332001, 28227.294317641812, 28694.282642934093, 28909.710902890703, 29081.85459072691, 29221.269468263465, 981.1709105805583, 1016.6136867990265, 1033.302520798473, 1037.3464717228098, 1080.308602494404, 14359.497417590543, 14956.0, 15017.624559386102, 15164.696706065817, 15259.160746159068, 334322.0, 335696.0, 337034.0, 339673.0, 341398.0, 47654.046919061424, 48051.0, 48529.0, 48781.5121848777, 48870.0, 1242.9937850310691, 1253.529926277646, 1282.249883817977, 1286.1897004887048, 1287.1247551664771, 26405.33986650349, 27812.44375112527, 27857.44285114327, 28159.43681126407, 28270.0, 41995.16009679851, 42688.0, 42689.5731042698, 42741.0, 42836.0, 299649.0, 301106.0, 301931.0, 302402.0, 302841.0, 24945.625815612417, 25001.624975625746, 25121.371965701004, 25354.746452535237, 25672.101476448235, 41792.74621761352, 42335.0, 42488.78755606202, 42603.5739642612, 43142.35286470642, 35717.1070723234, 35798.46302305415, 35963.10092247715, 36471.45292820663, 36950.63049369472, 35895.64104358923, 36035.45946810852, 36193.095172620895, 36435.635643643225, 36748.81625591855, 32005.35989280248, 37157.81421092877, 39055.0, 40144.795656130365, 40341.19317613573, 29520.0, 30115.247118822204, 30844.537331940486, 30865.69134308628, 31015.379692406477, 24197.0, 24765.25704228876, 24811.875940620183, 24818.379540511633, 24899.128530501344], "value": 16184.539976549131, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.34054361605496, 367.1115899523154, 374.78075325934327, 385.5566098986164, 385.9208862183253, 15896.20518974051, 16417.34330626775, 16676.58308542284, 16705.749413758804, 16945.745813812802, 15795.210239488008, 16809.32762689494, 17007.23467443965, 17074.23165957532, 17130.486085417426, 5023.899522009567, 5227.163653815391, 5271.262023316739, 5271.4464981177, 5290.206469029637, 3763.322601931651, 5164.096283150452, 5723.341815691208, 6015.398460153971, 6046.244219472566, 5999.0, 6005.459508644221, 6022.126791615213, 6026.216591843055, 6033.818985430444, 5838.2994040715175, 6089.269287685462, 6095.725692343811, 6099.054646529773, 6104.633721976696, 5109.795608175668, 5298.81454149103, 5302.045631786277, 5307.230451584499, 5414.702191379472, 20015.1993920243, 20046.79953200464, 20297.0, 20338.694919576217, 20418.0, 1931.0730849192325, 1998.430447322506, 2020.8888511131881, 2320.709911261092, 2336.3224664847176, 13075.649693851014, 13181.077324587282, 13218.339083045808, 13283.468661253539, 13678.31608419575, 1683.225716170563, 1689.5860514173983, 1718.5617667494835, 1752.6845167869778, 1788.1863751992812, 65890.0, 67614.66192669005, 68055.65972170107, 68191.0, 69173.96239056418, 8928.776780580407, 8989.966153892256, 9215.926416556355, 9317.767055823659, 9459.290553208537, 12369.257844529357, 12511.0, 12512.81230781539, 12529.248245105322, 12541.498340066295, 7084.716611335592, 7098.0062791209275, 7155.17715462718, 7178.425725941912, 7220.566765994057, 6998.090248267795, 7029.31122118464, 7085.89371159433, 7108.218096009435, 7137.678804453812, 5917.201177840936, 5968.46283834457, 6020.819375418744, 6058.242719660043, 6090.0, 1510.297711564128, 1672.3143511160365, 1703.8466538011392, 1710.0936503652836, 1755.2101554300361, 892.4288455388556, 901.7745563609097, 909.7998440343114, 954.8472244440856, 966.8791401074866, 15794.60513487149, 15807.525774226791, 16070.276837542338, 16284.26720797567, 17069.7439538407, 861.1087524412203, 880.6125304865839, 882.7131182365757, 888.5024386343669, 928.6471140966524, 8514.787130321667, 8715.912840871637, 8724.78188045304, 8788.648454061893, 8905.510196939102, 365374.0, 369228.0, 389213.0, 410134.2905996552, 417479.0, 75986.62006690042, 76523.61738191273, 78679.0, 79365.20634793694, 80842.59578702069, 1000.9249306302056, 1003.5333569890037, 1013.9898601013896, 1015.4009134610468, 1027.1525991057408, 13907.096038757449, 13913.652158696113, 14129.788053179005, 14163.504277350243, 14306.713865722419, 30625.0, 31275.218119546284, 31446.842765786023, 31902.52146217855, 32740.345193095527, 43062.0, 45402.772986134856, 45623.54376456193, 49297.0, 49313.50686493233, 7307.9634601828775, 7525.134609519756, 7585.16563178061, 7636.236376362319, 7684.0, 10744.247902646739, 11034.337939723642, 11481.540738370706, 11606.071514279007, 11659.941700291783, 10136.239782016526, 10464.267501274837, 10611.522481488506, 10722.142228621535, 10737.08734757523, 10065.496725163859, 10201.183905287708, 10326.690199294033, 10341.896581034394, 10498.527566259383, 10563.788724225626, 10622.150227981589, 10719.517621707198, 10932.781344373227, 10964.451777411257, 7290.343869051599, 7354.96322518384, 7386.298301661333, 7410.851782964418, 8216.876746848682, 8994.370394072352, 10575.841362379417, 10670.62652807179, 10796.730081747704, 10832.945835270773], "value": 8307.472405460341, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.621022323973, 1463.948761793337, 1575.9677411295597, 1762.4095927864164, 1811.52900245936, 6811.318868113186, 7559.244075592438, 7598.31615154636, 7849.646765895534, 7860.489068210562, 7700.614969251543, 7744.341730952876, 7781.9221807781905, 7797.25926037027, 7828.178041305652, 2197.7362716474004, 2215.6233440315186, 2218.6228341182036, 2220.6335954567476, 2222.411061068818, 2131.8081372676456, 2175.140819376353, 2178.4880553070016, 2189.2228258968075, 2190.3319487556287, 2172.7392712874475, 2204.272590045281, 2207.4371035386034, 2237.9776202238013, 2283.303592404316, 2205.0628482894704, 2227.9554408911895, 2228.8551244169157, 2230.35319757271, 2238.149503188786, 2163.123934806406, 2201.1745595401726, 2206.58074965756, 2206.6579680149603, 2212.3805334506364, 7859.842803143905, 7971.083325417535, 7978.481398709066, 7979.122296547375, 7987.480813747146, 4517.751523666197, 4609.1933911565675, 4625.306204069417, 4631.560001799824, 4634.513376095495, 2862.5265209026675, 3014.1861697341815, 3018.9245268868235, 3033.272014716474, 3047.7866549341556, 928.1414691410419, 933.1741408853146, 943.8725772020827, 953.5232383808096, 958.6548842416724, 10465.79068418635, 10528.263021588491, 10536.683899483029, 10571.260011799177, 10580.470976451224, 4057.431959525669, 4139.172165566899, 4264.488261408589, 4308.569143085729, 4322.027543802619, 9073.13805188506, 9084.18242358191, 9092.363534552518, 9093.545322733837, 9097.1812536872, 4503.932441013388, 4514.277715565494, 4520.163769702615, 4523.072770082125, 4532.954670453253, 3740.925181496355, 4049.838006479708, 4116.835326586963, 4138.985948442651, 4206.453161089039, 3767.3783825669007, 3807.0, 3847.442120892455, 3905.902352441155, 3907.2185562886966, 1256.5036810459817, 1271.465984286602, 1276.3937129863427, 1280.5262053040435, 1302.947882084706, 983.7442265011149, 1003.8343673293971, 1016.0855230292648, 1070.6252811516063, 1239.7024714068739, 7383.228490762318, 7419.406447484296, 7426.962865185747, 7475.850482990419, 7477.775666730006, 421.061033894411, 426.3604593110334, 427.4016377072124, 428.9335153051282, 429.0946103721146, 5710.143478478261, 5729.885402292014, 5937.584369094122, 5951.732172052268, 5958.791442299499, 9350.0, 9656.37233579815, 9688.224942004623, 9734.172595329477, 9763.804723905625, 9104.772380690536, 9375.343725939256, 9464.242860571137, 9700.078492543196, 9735.367201131903, 7173.282671732785, 7236.7828965130075, 7272.0, 7301.744438944717, 7309.122905251297, 7243.239459856639, 7427.665755041145, 7484.438667100098, 7528.134264559427, 7532.585707786125, 8535.53054582004, 8659.52372619512, 8728.56357182151, 8949.552522373986, 8965.50689712072, 8848.867266990872, 8966.596503157243, 9125.224355929555, 9201.585928633094, 9216.308776841897, 6174.320824709368, 6457.741690332334, 6680.966595167188, 6887.276835932155, 7037.366637002694, 7554.773356799305, 7563.0, 7568.735094271894, 7599.354054905395, 7644.388448924184, 6698.66506674674, 6744.0895479109695, 6932.029515867682, 6978.302169782981, 7033.226345102137, 6694.799156025327, 6744.730210791709, 6753.932460675331, 6815.420689241271, 6832.282610326043, 6800.0, 7074.71701131949, 7135.8572828544175, 7167.641617919187, 7262.455315851226, 6653.900191497035, 6685.866282674417, 6729.528932974645, 6745.898811517733, 6781.254062053072, 6648.700808463727, 6710.127683401127, 6714.026466162281, 6723.596584204964, 6726.058351830649], "value": 4363.025665935812, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.5062401405779, 317.2797749109523, 319.476059262809, 321.3877563242025, 329.6258746322923, 5242.239875218091, 5260.342457192851, 5339.679619222849, 5351.892962140755, 5369.355677318717, 5251.133562962106, 5263.710495922723, 5274.156135018397, 5281.155015197569, 5281.498257665516, 3851.114243723945, 3975.9204815903663, 4123.690723195772, 4134.4831896013, 4155.31437312843, 4068.8575899843513, 4112.3625837995005, 4134.56587058359, 4144.254034273829, 4150.626443620074, 4108.589141085882, 4111.876643700693, 4117.929338372015, 4121.629053385194, 4134.441850350195, 4025.879223623281, 4071.9389209161886, 4117.341225403921, 4127.566605506424, 4144.0, 3622.510961020255, 3631.3282042821897, 3635.654612811779, 3636.127329440915, 3649.1789347396625, 5022.447530771612, 5037.596992240612, 5048.343715317022, 5055.469175736568, 5063.0, 4666.836660716858, 4717.764111794397, 4752.453467851206, 4754.714717116949, 4777.402824646919, 5547.583931205136, 5578.107502799573, 5582.581306402036, 5582.972085139589, 5604.8318550443555, 3929.2141571685493, 3985.740926839746, 4006.419069234974, 4016.9397459038137, 4020.9396859047138, 5599.916001259984, 5693.487586117228, 5766.558360409897, 5838.095095260242, 5842.649441033552, 4102.097538541516, 4105.178964207171, 4118.5263694674895, 4121.793910304473, 4135.731177473514, 4126.442930204444, 4157.147784704189, 4162.4796900387455, 4173.979130104391, 4180.602842729936, 4730.787114579852, 4731.7634118293945, 4744.976275118603, 4745.1695953208055, 4754.144254034307, 5333.0, 5589.385167631557, 5608.327000759853, 5638.830835074954, 5639.0, 1367.6170672211797, 1386.2791348498724, 1395.8185435893472, 1396.4902810474105, 1397.1756663568544, 879.2131042716733, 911.3119594705954, 935.4948327902856, 972.0862389353985, 972.2562239886493, 4804.471508134103, 4835.782389792397, 4860.513948605182, 4868.707877527359, 4882.121218180761, 5650.802221922213, 5687.497501099503, 5691.886162276731, 5722.942770572325, 5725.713714314267, 4682.601978831769, 4859.2954021666665, 4871.658983871095, 4874.122657921537, 4957.206846904478, 3067.0, 3088.9536656950163, 3106.51848963411, 3109.7667674924473, 3113.735332496763, 5490.423505531941, 5504.2018907258225, 5505.623594101475, 5520.641158324696, 5521.033819081645, 5841.182234487175, 5876.206712093898, 5939.575016612651, 5988.7423641035, 5993.220881285405, 5490.80782172622, 5492.093804522209, 5501.367342755634, 5502.064649009598, 5504.7522861470525, 5651.660900345828, 5705.771769129188, 5736.827895163152, 5798.94201057984, 5800.100984347433, 5706.258186435737, 5732.824770921868, 5749.281339832521, 5758.3090029196765, 5770.163326317576, 5491.807786727445, 5492.725363731877, 5495.6153069286365, 5499.2576002240785, 5520.337559492887, 3782.2813665403487, 4005.9599404006754, 4013.0, 4029.979850100731, 4056.3104272274372, 5780.5953583248765, 5789.855253618524, 5802.65184088956, 5806.883862322815, 5807.767689292381, 5608.747606357642, 5618.353889302783, 5623.156526521055, 5636.1827535008015, 5646.85882852932, 5458.890822183614, 5544.279243698294, 5561.694106824163, 5588.441155884541, 5597.5499477914345, 5216.252555393986, 5496.148097044965, 5502.312210973629, 5516.806911758069, 5530.5022547970875, 5439.864003399946, 5642.852503410072, 5656.236408084856, 5685.0, 5695.658260504218, 5507.0637991542335, 5533.0, 5546.084895992116, 5548.583856210881, 5553.750081246434], "value": 4199.419855044679, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.5743623054437, 643.9162908821852, 676.0265218085956, 730.5434103685199, 735.9916913828056, 11677.824832627506, 11746.53013879446, 11822.940885295582, 11827.645170644873, 11869.703257418558, 12460.376981150928, 12826.61520154397, 12953.805692914613, 13027.413766380512, 13094.73810523789, 650.9576877502947, 799.6601444386142, 811.6144831205189, 815.0545367373848, 817.5830326533481, 803.04036676172, 807.422692774666, 810.6716779704229, 812.995935020327, 816.2123550773503, 857.3398483167957, 859.475719810918, 864.3474176996359, 864.9827003459927, 866.8136350684601, 856.7772379181396, 857.7598272483715, 863.1023735315265, 863.6113748813028, 863.952482613456, 626.2516293029831, 626.7023163997065, 627.8963970944789, 628.6196850905228, 629.0250112325876, 12661.620151395473, 12721.87278127216, 12728.299943503103, 12732.87267127326, 12775.48898044077, 12815.359232038361, 12825.486980520767, 12848.743025139538, 13020.934895325463, 13171.60485185446, 9907.603695852158, 10023.74940626483, 10199.898001020043, 10351.430671313075, 10365.118964887919, 3329.500574913758, 3403.744719146049, 3421.4525675891737, 3447.7414193935306, 3460.0657822387816, 42045.0, 44181.55818441806, 44556.55443445557, 50042.7497862512, 50057.0, 9266.768330791649, 9287.953560232156, 9339.392939458914, 9363.204127649089, 9369.953150234205, 16829.915850420915, 16872.66254674924, 16876.324947001984, 16877.240524176443, 16970.830291696926, 6570.145881035531, 6768.458523318122, 6843.0, 6911.0, 7018.227994920555, 3737.383331750231, 3773.735838491279, 3906.5898080701686, 3908.5895980922164, 3918.9608103918595, 2793.7485626293733, 2869.92825179368, 2874.453853767777, 2879.7840161987515, 2890.7976441648884, 501.36827597227756, 506.2431664661355, 509.5057793939872, 510.0971280832905, 518.3184112891536, 594.3877805859971, 595.8986972214734, 631.36232405271, 638.553012890969, 652.5758257132807, 7617.961910190414, 7751.0, 7789.961050194826, 7932.286094251545, 7948.602569871483, 461.92378257587796, 503.9823606173766, 582.7644206985275, 606.7845914700218, 620.5532016947881, 3568.553930758655, 3680.5031320771354, 3710.350688629479, 3742.8128593570214, 3752.5121734174927, 41949.79025104855, 47311.0, 47387.526124739, 51031.234531482056, 51772.0, 42262.788686056985, 42512.78743606262, 43487.0, 43871.78064109659, 44317.89205269894, 38788.64239751595, 39581.802090989935, 40031.39952900709, 40157.79921100376, 40633.1873362537, 7525.285097915689, 7710.653020614198, 7713.92286077132, 7779.883301750365, 7869.606519674108, 28973.710262897945, 29040.12879613615, 29090.12729618115, 29613.555796662637, 29730.256743581584, 37245.6275437253, 38009.23981520409, 38142.046448839, 38369.0, 38536.6146338533, 10667.168868756913, 10733.409662468326, 10769.246152769545, 10819.621313253998, 11045.613403530839, 11631.302121872715, 11794.882051179378, 11963.102767292661, 12120.75758484843, 12487.750244994868, 10928.836067458835, 11107.666769996913, 11472.082233421139, 11676.474558644712, 11696.181267311207, 10795.946020269848, 10934.890651093387, 11082.501287442246, 11342.20604557673, 11388.259763115371, 10849.620263290746, 10854.67435976922, 10866.239363244496, 11075.667729968114, 11172.162087843282, 9465.574049167943, 9537.52312384392, 9610.423374597547, 9665.613375464902, 9894.0, 9535.427874327563, 9620.37467564606, 9775.902240977499, 9779.706608801747, 9904.405735655884], "value": 5905.845789938124, "unit": "score"}], "name": "dromaeo_css", "value": 6389.418909121909, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 108.0, 114.0, 114.0, 115.0, 126.0, 113.0, 115.0, 113.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 132.0, 157.0, 173.0, 135.0, 157.0, 166.0, 136.0, 189.0, 133.0], "value": 154.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 163.0, 164.0, 167.0, 168.0, 163.0, 166.0, 162.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 79.0, 75.0, 73.0, 73.0, 76.0, 144.0, 75.0, 74.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 147.0, 93.0, 94.0, 93.0, 139.0, 94.0, 95.0, 138.0], "value": 108.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 147.0, 149.0, 149.0, 147.0, 150.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 66.0, 66.0, 66.0, 68.0, 65.0, 68.0, 64.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 67.0, 67.0, 64.0, 64.0, 64.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 89.0, 86.0, 85.0, 84.0, 87.0, 86.0, 86.0, 86.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 150.0, 145.0, 136.0, 144.0, 155.0, 143.0, 142.0, 144.0, 144.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 170.0, 179.0, 172.0, 172.0, 173.0, 176.0, 169.0, 171.0, 170.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 71.0, 72.0, 73.0, 80.0, 74.0, 72.0, 72.0, 77.0], "value": 73.4, "unit": "score"}], "name": "kraken", "value": 1592.0, "alertThreshold": 2.0}]} 07:47:18 INFO - Return code: 0 07:47:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:47:18 ERROR - # TBPL SUCCESS # 07:47:18 INFO - Running post-action listener: _resource_record_post_action 07:47:18 INFO - Running post-run listener: _resource_record_post_run 07:47:19 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 2256896; Write bytes: 528420864; Read time: 1116; Write time: 712416 07:47:19 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 241319936; Read time: 0; Write time: 437604 07:47:19 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 2256896; Write bytes: 287100928; Read time: 1116; Write time: 274812 07:47:19 INFO - Running post-run listener: _upload_blobber_files 07:47:19 INFO - Blob upload gear active. 07:47:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:47:19 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 07:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:47:19 INFO - (blobuploader) - INFO - Open directory for files ... 07:47:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:47:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:47:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:20 INFO - (blobuploader) - INFO - Done attempting. 07:47:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:47:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:47:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:21 INFO - (blobuploader) - INFO - Done attempting. 07:47:21 INFO - (blobuploader) - INFO - Iteration through files over. 07:47:21 INFO - Return code: 0 07:47:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:47:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:47:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d6e569a27bb9ada2a68c0a59f9277f648a57799724a720c4ac359eba83a05fae21c205153f8812600a714487cd4c227cd0ce19499c3a21a4406612a1f4551c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a09f7c7ca1a05ad022d50df2cee317615a6083d34852c4ac57dc11cb5e766e74e6859c202fad7917dbef1b6dbaa8f5fb1430cfa6da2f929facb141ffce0f451c"} 07:47:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:47:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:47:21 INFO - Contents: 07:47:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d6e569a27bb9ada2a68c0a59f9277f648a57799724a720c4ac359eba83a05fae21c205153f8812600a714487cd4c227cd0ce19499c3a21a4406612a1f4551c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a09f7c7ca1a05ad022d50df2cee317615a6083d34852c4ac57dc11cb5e766e74e6859c202fad7917dbef1b6dbaa8f5fb1430cfa6da2f929facb141ffce0f451c"} 07:47:21 INFO - Running post-run listener: copy_logs_to_upload_dir 07:47:21 INFO - Copying logs to upload dir... 07:47:21 INFO - mkdir: /builds/slave/test/build/upload/logs 07:47:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.386125 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-08 07:47:21.415526) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 07:47:21.421760) ========= 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=a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397 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/Fx-Team-Non-PGO/sha512/6d6e569a27bb9ada2a68c0a59f9277f648a57799724a720c4ac359eba83a05fae21c205153f8812600a714487cd4c227cd0ce19499c3a21a4406612a1f4551c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a09f7c7ca1a05ad022d50df2cee317615a6083d34852c4ac57dc11cb5e766e74e6859c202fad7917dbef1b6dbaa8f5fb1430cfa6da2f929facb141ffce0f451c"} build_url:https://queue.taskcluster.net/v1/task/e0gHHs3wSyuar1mAqMwTlg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/e0gHHs3wSyuar1mAqMwTlg/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/Fx-Team-Non-PGO/sha512/6d6e569a27bb9ada2a68c0a59f9277f648a57799724a720c4ac359eba83a05fae21c205153f8812600a714487cd4c227cd0ce19499c3a21a4406612a1f4551c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a09f7c7ca1a05ad022d50df2cee317615a6083d34852c4ac57dc11cb5e766e74e6859c202fad7917dbef1b6dbaa8f5fb1430cfa6da2f929facb141ffce0f451c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 07:47:21.450409) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 07:47:21.451121) ========= 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=a0d2d2de893abaa8702a9954000001a7-1460125416.226024-705214397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 07:47:21.536024) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 07:47:21.536762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 07:47:21.537239) ========= ========= Total master_lag: 0.33 =========