builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1460421793.29 results: success (0) buildid: 20160411160652 builduid: 0dc00d7666f1478faf79f7636684998e revision: 4118760a3981d37b7ae31d8c6a9326318e6b3ee8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.294926) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.295366) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.295670) ========= 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=1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006478 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.318652) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.318932) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.331775) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.332059) ========= 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=1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.380575) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.380856) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.381244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.381539) ========= 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=1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-11 17:43:13-- 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% 224M=0s 2016-04-11 17:43:13 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193569 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.587308) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.587613) ========= 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=1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017971 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:13.644898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-11 17:43:13.645231) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4118760a3981d37b7ae31d8c6a9326318e6b3ee8 --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 4118760a3981d37b7ae31d8c6a9326318e6b3ee8 --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=1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-11 17:43:13,812 truncating revision to first 12 chars 2016-04-11 17:43:13,812 Setting DEBUG logging. 2016-04-11 17:43:13,812 attempt 1/10 2016-04-11 17:43:13,812 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4118760a3981?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 17:43:14,697 unpacking tar archive at: fx-team-4118760a3981/testing/mozharness/ program finished with exit code 0 elapsedTime=1.140973 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-11 17:43:14.799855) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:14.800195) ========= echo 4118760a3981d37b7ae31d8c6a9326318e6b3ee8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4118760a3981d37b7ae31d8c6a9326318e6b3ee8'] 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=1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4118760a3981d37b7ae31d8c6a9326318e6b3ee8 program finished with exit code 0 elapsedTime=0.004887 script_repo_revision: '4118760a3981d37b7ae31d8c6a9326318e6b3ee8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:14.851406) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:14.851694) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 17:43:14.861955) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-11 17:43:14.862267) ========= /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=1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:43:15 INFO - MultiFileLogger online at 20160411 17:43:15 in /builds/slave/test 17:43:15 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 17:43:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:43:15 INFO - {'append_to_log': False, 17:43:15 INFO - 'base_work_dir': '/builds/slave/test', 17:43:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:43:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:43:15 INFO - 'branch': 'Fx-Team-Non-PGO', 17:43:15 INFO - 'buildbot_json_path': 'buildprops.json', 17:43:15 INFO - 'config_files': ('talos/linux_config.py',), 17:43:15 INFO - 'default_actions': ('clobber', 17:43:15 INFO - 'read-buildbot-config', 17:43:15 INFO - 'download-and-extract', 17:43:15 INFO - 'populate-webroot', 17:43:15 INFO - 'create-virtualenv', 17:43:15 INFO - 'install', 17:43:15 INFO - 'run-tests'), 17:43:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:43:15 INFO - 'download_minidump_stackwalk': True, 17:43:15 INFO - 'download_symbols': 'ondemand', 17:43:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:43:15 INFO - 'tooltool.py': '/tools/tooltool.py', 17:43:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:43:15 INFO - '/tools/misc-python/virtualenv.py')}, 17:43:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:43:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:43:15 INFO - 'installer_path': 'installer.exe', 17:43:15 INFO - 'log_level': 'info', 17:43:15 INFO - 'log_name': 'talos', 17:43:15 INFO - 'log_to_console': True, 17:43:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:43:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:43:15 INFO - 'opt_config_files': (), 17:43:15 INFO - 'pip_index': False, 17:43:15 INFO - 'sps_profile': False, 17:43:15 INFO - 'sps_profile_interval': 0, 17:43:15 INFO - 'suite': 'dromaeojs-e10s', 17:43:15 INFO - 'system_bits': '32', 17:43:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:43:15 INFO - 'title': 'talos-linux64-ix-027', 17:43:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:43:15 INFO - 'use_talos_json': True, 17:43:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:43:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:43:15 INFO - 'work_dir': 'build'} 17:43:15 INFO - ##### 17:43:15 INFO - ##### Running clobber step. 17:43:15 INFO - ##### 17:43:15 INFO - Running pre-action listener: _resource_record_pre_action 17:43:15 INFO - Running main action method: clobber 17:43:15 INFO - rmtree: /builds/slave/test/build 17:43:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:43:15 INFO - Running post-action listener: _resource_record_post_action 17:43:15 INFO - ##### 17:43:15 INFO - ##### Running read-buildbot-config step. 17:43:15 INFO - ##### 17:43:15 INFO - Running pre-action listener: _resource_record_pre_action 17:43:15 INFO - Running main action method: read_buildbot_config 17:43:15 INFO - Using buildbot properties: 17:43:15 INFO - { 17:43:15 INFO - "project": "", 17:43:15 INFO - "product": "firefox", 17:43:15 INFO - "script_repo_revision": "production", 17:43:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:43:15 INFO - "repository": "", 17:43:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:43:15 INFO - "buildid": "20160411160652", 17:43:15 INFO - "pgo_build": "False", 17:43:15 INFO - "basedir": "/builds/slave/test", 17:43:15 INFO - "buildnumber": 1387, 17:43:15 INFO - "slavename": "talos-linux64-ix-027", 17:43:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:43:15 INFO - "platform": "ubuntu64_hw", 17:43:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:43:15 INFO - "branch": "fx-team", 17:43:15 INFO - "repo_path": "integration/fx-team", 17:43:15 INFO - "revision": "4118760a3981d37b7ae31d8c6a9326318e6b3ee8", 17:43:15 INFO - "stage_platform": "linux64", 17:43:15 INFO - "builduid": "0dc00d7666f1478faf79f7636684998e", 17:43:15 INFO - "slavebuilddir": "test" 17:43:15 INFO - } 17:43:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:43:15 INFO - Running post-action listener: _resource_record_post_action 17:43:15 INFO - ##### 17:43:15 INFO - ##### Running download-and-extract step. 17:43:15 INFO - ##### 17:43:15 INFO - Running pre-action listener: _resource_record_pre_action 17:43:15 INFO - Running main action method: download_and_extract 17:43:15 INFO - mkdir: /builds/slave/test/build/tests 17:43:15 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')]} 17:43:15 INFO - https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:43:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:43:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:43:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/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 17:43:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/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 17:43:25 INFO - Downloaded 1361 bytes. 17:43:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:43:25 INFO - Using the following test package requirements: 17:43:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:43:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:43:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:43:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:25 INFO - u'jsshell-linux-x86_64.zip'], 17:43:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:43:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:43:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:43:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:43:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:43:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:43:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:43:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:25 INFO - https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:43:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:43:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:43:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/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 17:43:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/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 17:43:35 INFO - Downloaded 22190342 bytes. 17:43:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:43:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:43:36 INFO - Return code: 0 17:43:36 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 17:43:36 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')]} 17:43:36 INFO - https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:43:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:43:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:43:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/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 17:43:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/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 17:43:37 INFO - Downloaded 22190342 bytes. 17:43:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:43:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:43:38 INFO - Return code: 0 17:43: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')]} 17:43:38 INFO - https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:43:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:43:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:43:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/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 17:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/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 17:43:40 INFO - Downloaded 10841046 bytes. 17:43:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:43:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:43:40 INFO - Return code: 0 17:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:40 INFO - https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:43:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:43:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:43:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/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 17:43:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZ3p0sKQRvKR-agScTBY6g/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 17:43:43 INFO - Downloaded 54105197 bytes. 17:43:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:43:43 INFO - mkdir: /builds/slave/test/properties 17:43:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:43:43 INFO - Writing to file /builds/slave/test/properties/build_url 17:43:43 INFO - Contents: 17:43:43 INFO - build_url:https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:43:44 INFO - Running post-action listener: _resource_record_post_action 17:43:44 INFO - Running post-action listener: set_extra_try_arguments 17:43:44 INFO - ##### 17:43:44 INFO - ##### Running populate-webroot step. 17:43:44 INFO - ##### 17:43:44 INFO - Running pre-action listener: _resource_record_pre_action 17:43:44 INFO - Running main action method: populate_webroot 17:43:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:43:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:43:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:43:44 INFO - '--tppagecycles', 17:43:44 INFO - '7'], 17:43:44 INFO - 'tests': ['tsvgm']}}, 17:43:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:43:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:43:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:43:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:43:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:44 INFO - 'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:44 INFO - 'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['damp', 'tps']}, 17:43:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:44 INFO - 'tests': ['damp', 'tps']}, 17:43:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['dromaeo_dom']}, 17:43:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:43:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['a11yr', 17:43:44 INFO - 'ts_paint', 17:43:44 INFO - 'tpaint', 17:43:44 INFO - 'sessionrestore', 17:43:44 INFO - 'sessionrestore_no_auto_restore', 17:43:44 INFO - 'tabpaint']}, 17:43:44 INFO - 'other-e10s': {'tests': ['a11yr', 17:43:44 INFO - 'ts_paint', 17:43:44 INFO - 'tpaint', 17:43:44 INFO - 'sessionrestore', 17:43:44 INFO - 'sessionrestore_no_auto_restore', 17:43:44 INFO - 'tabpaint']}, 17:43:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:43:44 INFO - 'ts_paint', 17:43:44 INFO - 'tpaint', 17:43:44 INFO - 'sessionrestore', 17:43:44 INFO - 'sessionrestore_no_auto_restore', 17:43:44 INFO - 'tabpaint']}, 17:43:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:43:44 INFO - 'ts_paint', 17:43:44 INFO - 'tpaint', 17:43:44 INFO - 'sessionrestore', 17:43:44 INFO - 'sessionrestore_no_auto_restore', 17:43:44 INFO - 'tabpaint']}, 17:43:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['a11yr', 17:43:44 INFO - 'ts_paint', 17:43:44 INFO - 'tpaint', 17:43:44 INFO - 'sessionrestore', 17:43:44 INFO - 'sessionrestore_no_auto_restore', 17:43:44 INFO - 'tabpaint']}, 17:43:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['a11yr', 17:43:44 INFO - 'ts_paint', 17:43:44 INFO - 'tpaint', 17:43:44 INFO - 'sessionrestore', 17:43:44 INFO - 'sessionrestore_no_auto_restore', 17:43:44 INFO - 'tabpaint']}, 17:43:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['tsvgx', 17:43:44 INFO - 'tsvgr_opacity', 17:43:44 INFO - 'tart', 17:43:44 INFO - 'tscrollx', 17:43:44 INFO - 'cart']}, 17:43:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:43:44 INFO - 'tsvgr_opacity', 17:43:44 INFO - 'tart', 17:43:44 INFO - 'tscrollx', 17:43:44 INFO - 'cart']}, 17:43:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:44 INFO - 'talos_options': ['--disable-e10s'], 17:43:44 INFO - 'tests': ['tp5o']}, 17:43:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:44 INFO - 'tests': ['tp5o']}, 17:43:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:44 INFO - 'talos_options': ['--disable-e10s', 17:43:44 INFO - '--xperf_path', 17:43:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:44 INFO - 'tests': ['tp5n']}, 17:43:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:44 INFO - 'talos_options': ['--xperf_path', 17:43:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:44 INFO - 'tests': ['tp5n']}}, 17:43:44 INFO - 'talos.zip': {'path': '', 17:43:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:43:44 INFO - Running post-action listener: _resource_record_post_action 17:43:44 INFO - ##### 17:43:44 INFO - ##### Running create-virtualenv step. 17:43:44 INFO - ##### 17:43:44 INFO - Running pre-action listener: _resource_record_pre_action 17:43:44 INFO - Running main action method: create_virtualenv 17:43:44 INFO - Creating virtualenv /builds/slave/test/build/venv 17:43:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:43:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:43:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:43:44 INFO - Using real prefix '/usr' 17:43:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:43:44 INFO - Installing distribute.............................................................................................................................................................................................done. 17:43:46 INFO - Installing pip.................done. 17:43:46 INFO - Return code: 0 17:43:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:46 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 0x7f5f46960f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049410>, '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 0x104a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a7a0>, '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': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', '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 17:43:46 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 17:43:46 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 17:43:46 INFO - Using env: {'DISPLAY': ':0', 17:43:46 INFO - 'HOME': '/home/cltbld', 17:43:46 INFO - 'LANG': 'en_US.UTF-8', 17:43:46 INFO - 'LANGUAGE': 'en_US:en', 17:43:46 INFO - 'LOGNAME': 'cltbld', 17:43:46 INFO - 'MAIL': '/var/mail/cltbld', 17:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:46 INFO - 'MOZ_NO_REMOTE': '1', 17:43:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:46 INFO - 'NO_EM_RESTART': '1', 17:43:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:46 INFO - 'PWD': '/builds/slave/test', 17:43:46 INFO - 'SHELL': '/bin/bash', 17:43:46 INFO - 'SHLVL': '1', 17:43:46 INFO - 'TERM': 'linux', 17:43:46 INFO - 'TMOUT': '86400', 17:43:46 INFO - 'USER': 'cltbld', 17:43:46 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', 17:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:46 INFO - '_': '/tools/buildbot/bin/python'} 17:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:43:47 INFO - Cleaning up... 17:43:47 INFO - Return code: 0 17:43:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f46960f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049410>, '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 0x104a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a7a0>, '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': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', '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 17:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:43:47 INFO - Using env: {'DISPLAY': ':0', 17:43:47 INFO - 'HOME': '/home/cltbld', 17:43:47 INFO - 'LANG': 'en_US.UTF-8', 17:43:47 INFO - 'LANGUAGE': 'en_US:en', 17:43:47 INFO - 'LOGNAME': 'cltbld', 17:43:47 INFO - 'MAIL': '/var/mail/cltbld', 17:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:47 INFO - 'MOZ_NO_REMOTE': '1', 17:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:47 INFO - 'NO_EM_RESTART': '1', 17:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:47 INFO - 'PWD': '/builds/slave/test', 17:43:47 INFO - 'SHELL': '/bin/bash', 17:43:47 INFO - 'SHLVL': '1', 17:43:47 INFO - 'TERM': 'linux', 17:43:47 INFO - 'TMOUT': '86400', 17:43:47 INFO - 'USER': 'cltbld', 17:43:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', 17:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:47 INFO - '_': '/tools/buildbot/bin/python'} 17:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:47 INFO - Downloading/unpacking psutil>=0.7.1 17:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:43:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:49 INFO - Installing collected packages: psutil 17:43:49 INFO - Running setup.py install for psutil 17:43:49 INFO - building 'psutil._psutil_linux' extension 17:43:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:43:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:43:49 INFO - building 'psutil._psutil_posix' extension 17:43:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:43:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:43:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:50 INFO - Successfully installed psutil 17:43:50 INFO - Cleaning up... 17:43:50 INFO - Return code: 0 17:43:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f46960f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049410>, '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 0x104a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a7a0>, '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': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', '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 17:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:43:50 INFO - Using env: {'DISPLAY': ':0', 17:43:50 INFO - 'HOME': '/home/cltbld', 17:43:50 INFO - 'LANG': 'en_US.UTF-8', 17:43:50 INFO - 'LANGUAGE': 'en_US:en', 17:43:50 INFO - 'LOGNAME': 'cltbld', 17:43:50 INFO - 'MAIL': '/var/mail/cltbld', 17:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:50 INFO - 'MOZ_NO_REMOTE': '1', 17:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:50 INFO - 'NO_EM_RESTART': '1', 17:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:50 INFO - 'PWD': '/builds/slave/test', 17:43:50 INFO - 'SHELL': '/bin/bash', 17:43:50 INFO - 'SHLVL': '1', 17:43:50 INFO - 'TERM': 'linux', 17:43:50 INFO - 'TMOUT': '86400', 17:43:50 INFO - 'USER': 'cltbld', 17:43:50 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', 17:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:50 INFO - '_': '/tools/buildbot/bin/python'} 17:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:43:52 INFO - Installing collected packages: mozsystemmonitor 17:43:52 INFO - Running setup.py install for mozsystemmonitor 17:43:52 INFO - Successfully installed mozsystemmonitor 17:43:52 INFO - Cleaning up... 17:43:52 INFO - Return code: 0 17:43:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43: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')]} 17:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f46960f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049410>, '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 0x104a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a7a0>, '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': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', '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 17:43:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:43:52 INFO - Using env: {'DISPLAY': ':0', 17:43:52 INFO - 'HOME': '/home/cltbld', 17:43:52 INFO - 'LANG': 'en_US.UTF-8', 17:43:52 INFO - 'LANGUAGE': 'en_US:en', 17:43:52 INFO - 'LOGNAME': 'cltbld', 17:43:52 INFO - 'MAIL': '/var/mail/cltbld', 17:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:52 INFO - 'MOZ_NO_REMOTE': '1', 17:43:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:52 INFO - 'NO_EM_RESTART': '1', 17:43:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:52 INFO - 'PWD': '/builds/slave/test', 17:43:52 INFO - 'SHELL': '/bin/bash', 17:43:52 INFO - 'SHLVL': '1', 17:43:52 INFO - 'TERM': 'linux', 17:43:52 INFO - 'TMOUT': '86400', 17:43:52 INFO - 'USER': 'cltbld', 17:43:52 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', 17:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:52 INFO - '_': '/tools/buildbot/bin/python'} 17:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:52 INFO - Downloading/unpacking blobuploader==1.2.4 17:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:54 INFO - Downloading blobuploader-1.2.4.tar.gz 17:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:43:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:43:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:55 INFO - Downloading docopt-0.6.1.tar.gz 17:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:43:55 INFO - Installing collected packages: blobuploader, requests, docopt 17:43:55 INFO - Running setup.py install for blobuploader 17:43:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:43:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:43:55 INFO - Running setup.py install for requests 17:43:55 INFO - Running setup.py install for docopt 17:43:55 INFO - Successfully installed blobuploader requests docopt 17:43:55 INFO - Cleaning up... 17:43:55 INFO - Return code: 0 17:43:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f46960f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049410>, '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 0x104a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a7a0>, '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': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', '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 17:43:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:43:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:43:55 INFO - Using env: {'DISPLAY': ':0', 17:43:55 INFO - 'HOME': '/home/cltbld', 17:43:55 INFO - 'LANG': 'en_US.UTF-8', 17:43:55 INFO - 'LANGUAGE': 'en_US:en', 17:43:55 INFO - 'LOGNAME': 'cltbld', 17:43:55 INFO - 'MAIL': '/var/mail/cltbld', 17:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:55 INFO - 'MOZ_NO_REMOTE': '1', 17:43:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:55 INFO - 'NO_EM_RESTART': '1', 17:43:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:55 INFO - 'PWD': '/builds/slave/test', 17:43:55 INFO - 'SHELL': '/bin/bash', 17:43:55 INFO - 'SHLVL': '1', 17:43:55 INFO - 'TERM': 'linux', 17:43:55 INFO - 'TMOUT': '86400', 17:43:55 INFO - 'USER': 'cltbld', 17:43:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', 17:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:55 INFO - '_': '/tools/buildbot/bin/python'} 17:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:56 INFO - Running setup.py (path:/tmp/pip-edjBP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:56 INFO - Running setup.py (path:/tmp/pip-lp9GIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:56 INFO - Running setup.py (path:/tmp/pip-iXcZUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:56 INFO - Running setup.py (path:/tmp/pip-mCEZC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:56 INFO - Running setup.py (path:/tmp/pip-Viw_iS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:56 INFO - Running setup.py (path:/tmp/pip-i6LS2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:56 INFO - Running setup.py (path:/tmp/pip-PzInkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:56 INFO - Running setup.py (path:/tmp/pip-mm7sxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:56 INFO - Running setup.py (path:/tmp/pip-KSNVkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:56 INFO - Running setup.py (path:/tmp/pip-3vpOBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:56 INFO - Running setup.py (path:/tmp/pip-iIY58u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:56 INFO - Running setup.py (path:/tmp/pip-gCTnJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:56 INFO - Running setup.py (path:/tmp/pip-9HoaCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:56 INFO - Running setup.py (path:/tmp/pip-VgVqTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:57 INFO - Running setup.py (path:/tmp/pip-TpD6Gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:57 INFO - Running setup.py (path:/tmp/pip-z6Gz43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:57 INFO - Running setup.py (path:/tmp/pip-Nev7Yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:43:57 INFO - Running setup.py install for manifestparser 17:43:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:43:57 INFO - Running setup.py install for mozcrash 17:43:57 INFO - Running setup.py install for mozdebug 17:43:57 INFO - Running setup.py install for mozdevice 17:43:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:43:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:43:57 INFO - Running setup.py install for mozfile 17:43:57 INFO - Running setup.py install for mozhttpd 17:43:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:43:57 INFO - Running setup.py install for mozinfo 17:43:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:43:57 INFO - Running setup.py install for mozInstall 17:43:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Running setup.py install for mozleak 17:43:58 INFO - Running setup.py install for mozlog 17:43:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Running setup.py install for moznetwork 17:43:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Running setup.py install for mozprocess 17:43:58 INFO - Running setup.py install for mozprofile 17:43:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Running setup.py install for mozrunner 17:43:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:43:58 INFO - Running setup.py install for mozscreenshot 17:43:58 INFO - Running setup.py install for moztest 17:43:58 INFO - Running setup.py install for mozversion 17:43:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:43:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:43:59 INFO - Cleaning up... 17:43:59 INFO - Return code: 0 17:43:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f46960f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049410>, '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 0x104a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a7a0>, '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': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', '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 17:43:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:43:59 INFO - Using env: {'DISPLAY': ':0', 17:43:59 INFO - 'HOME': '/home/cltbld', 17:43:59 INFO - 'LANG': 'en_US.UTF-8', 17:43:59 INFO - 'LANGUAGE': 'en_US:en', 17:43:59 INFO - 'LOGNAME': 'cltbld', 17:43:59 INFO - 'MAIL': '/var/mail/cltbld', 17:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:59 INFO - 'MOZ_NO_REMOTE': '1', 17:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:43:59 INFO - 'NO_EM_RESTART': '1', 17:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:59 INFO - 'PWD': '/builds/slave/test', 17:43:59 INFO - 'SHELL': '/bin/bash', 17:43:59 INFO - 'SHLVL': '1', 17:43:59 INFO - 'TERM': 'linux', 17:43:59 INFO - 'TMOUT': '86400', 17:43:59 INFO - 'USER': 'cltbld', 17:43:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', 17:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:59 INFO - '_': '/tools/buildbot/bin/python'} 17:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:59 INFO - Running setup.py (path:/tmp/pip-DWOGWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:59 INFO - Running setup.py (path:/tmp/pip-i8oQ6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:59 INFO - Running setup.py (path:/tmp/pip-Btw9yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:59 INFO - Running setup.py (path:/tmp/pip-Z4j866-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:59 INFO - Running setup.py (path:/tmp/pip-YscyLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:59 INFO - Running setup.py (path:/tmp/pip-sbHwZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:59 INFO - Running setup.py (path:/tmp/pip-OQJElZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:59 INFO - Running setup.py (path:/tmp/pip-ORkHZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:59 INFO - Running setup.py (path:/tmp/pip-70dHdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:59 INFO - Running setup.py (path:/tmp/pip-Gz6IcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:59 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)) 17:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:59 INFO - Running setup.py (path:/tmp/pip-wMQLO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:00 INFO - Running setup.py (path:/tmp/pip-Z8UNLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:00 INFO - Running setup.py (path:/tmp/pip-YkOMfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:00 INFO - Running setup.py (path:/tmp/pip-RQrQ0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:00 INFO - Running setup.py (path:/tmp/pip-Tq9LmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:00 INFO - Running setup.py (path:/tmp/pip-k2MOM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:00 INFO - Running setup.py (path:/tmp/pip-7aUjVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:44:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:02 INFO - Downloading blessings-1.6.tar.gz 17:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:44:02 INFO - Installing collected packages: blessings 17:44:02 INFO - Running setup.py install for blessings 17:44:02 INFO - Successfully installed blessings 17:44:02 INFO - Cleaning up... 17:44:02 INFO - Return code: 0 17:44:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:44:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:02 INFO - Reading from file tmpfile_stdout 17:44:02 INFO - Current package versions: 17:44:02 INFO - argparse == 1.2.1 17:44:02 INFO - blessings == 1.6 17:44:02 INFO - blobuploader == 1.2.4 17:44:02 INFO - docopt == 0.6.1 17:44:02 INFO - manifestparser == 1.1 17:44:02 INFO - mozInstall == 1.12 17:44:02 INFO - mozcrash == 0.17 17:44:02 INFO - mozdebug == 0.1 17:44:02 INFO - mozdevice == 0.48 17:44:02 INFO - mozfile == 1.2 17:44:02 INFO - mozhttpd == 0.7 17:44:02 INFO - mozinfo == 0.9 17:44:02 INFO - mozleak == 0.1 17:44:02 INFO - mozlog == 3.1 17:44:02 INFO - moznetwork == 0.27 17:44:02 INFO - mozprocess == 0.22 17:44:02 INFO - mozprofile == 0.28 17:44:02 INFO - mozrunner == 6.11 17:44:02 INFO - mozscreenshot == 0.1 17:44:02 INFO - mozsystemmonitor == 0.0 17:44:02 INFO - moztest == 0.7 17:44:02 INFO - mozversion == 1.4 17:44:02 INFO - psutil == 3.1.1 17:44:02 INFO - requests == 1.2.3 17:44:02 INFO - wsgiref == 0.1.2 17:44:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f46960f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049410>, '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 0x104a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a7a0>, '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': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', '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 17:44:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:44:02 INFO - Using env: {'DISPLAY': ':0', 17:44:02 INFO - 'HOME': '/home/cltbld', 17:44:02 INFO - 'LANG': 'en_US.UTF-8', 17:44:02 INFO - 'LANGUAGE': 'en_US:en', 17:44:02 INFO - 'LOGNAME': 'cltbld', 17:44:02 INFO - 'MAIL': '/var/mail/cltbld', 17:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:02 INFO - 'MOZ_NO_REMOTE': '1', 17:44:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:02 INFO - 'NO_EM_RESTART': '1', 17:44:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:02 INFO - 'PWD': '/builds/slave/test', 17:44:02 INFO - 'SHELL': '/bin/bash', 17:44:02 INFO - 'SHLVL': '1', 17:44:02 INFO - 'TERM': 'linux', 17:44:02 INFO - 'TMOUT': '86400', 17:44:02 INFO - 'USER': 'cltbld', 17:44:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', 17:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:02 INFO - '_': '/tools/buildbot/bin/python'} 17:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:44:03 INFO - Cleaning up... 17:44:03 INFO - Return code: 0 17:44:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f46960f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049410>, '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 0x104a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a7a0>, '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': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', '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 17:44:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:44:03 INFO - Using env: {'DISPLAY': ':0', 17:44:03 INFO - 'HOME': '/home/cltbld', 17:44:03 INFO - 'LANG': 'en_US.UTF-8', 17:44:03 INFO - 'LANGUAGE': 'en_US:en', 17:44:03 INFO - 'LOGNAME': 'cltbld', 17:44:03 INFO - 'MAIL': '/var/mail/cltbld', 17:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:03 INFO - 'MOZ_NO_REMOTE': '1', 17:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:03 INFO - 'NO_EM_RESTART': '1', 17:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:03 INFO - 'PWD': '/builds/slave/test', 17:44:03 INFO - 'SHELL': '/bin/bash', 17:44:03 INFO - 'SHLVL': '1', 17:44:03 INFO - 'TERM': 'linux', 17:44:03 INFO - 'TMOUT': '86400', 17:44:03 INFO - 'USER': 'cltbld', 17:44:03 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', 17:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:03 INFO - '_': '/tools/buildbot/bin/python'} 17:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:03 INFO - Downloading/unpacking jsonschema 17:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:44:05 INFO - Downloading/unpacking functools32 (from jsonschema) 17:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:05 INFO - Downloading functools32-3.2.3-2.tar.gz 17:44:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:44:05 INFO - warning: no files found matching '*.txt' 17:44:05 INFO - no previously-included directories found matching 'build' 17:44:05 INFO - no previously-included directories found matching 'dist' 17:44:05 INFO - no previously-included directories found matching '.git*' 17:44:05 INFO - Installing collected packages: jsonschema, functools32 17:44:05 INFO - Running setup.py install for functools32 17:44:05 INFO - warning: no files found matching '*.txt' 17:44:05 INFO - no previously-included directories found matching 'build' 17:44:05 INFO - no previously-included directories found matching 'dist' 17:44:05 INFO - no previously-included directories found matching '.git*' 17:44:05 INFO - Successfully installed jsonschema functools32 17:44:05 INFO - Cleaning up... 17:44:05 INFO - Return code: 0 17:44:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f46960f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfba5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049410>, '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 0x104a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a7a0>, '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': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', '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 17:44:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:44:05 INFO - Using env: {'DISPLAY': ':0', 17:44:05 INFO - 'HOME': '/home/cltbld', 17:44:05 INFO - 'LANG': 'en_US.UTF-8', 17:44:05 INFO - 'LANGUAGE': 'en_US:en', 17:44:05 INFO - 'LOGNAME': 'cltbld', 17:44:05 INFO - 'MAIL': '/var/mail/cltbld', 17:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:05 INFO - 'MOZ_NO_REMOTE': '1', 17:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:05 INFO - 'NO_EM_RESTART': '1', 17:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:05 INFO - 'PWD': '/builds/slave/test', 17:44:05 INFO - 'SHELL': '/bin/bash', 17:44:05 INFO - 'SHLVL': '1', 17:44:05 INFO - 'TERM': 'linux', 17:44:05 INFO - 'TMOUT': '86400', 17:44:05 INFO - 'USER': 'cltbld', 17:44:05 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', 17:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:05 INFO - '_': '/tools/buildbot/bin/python'} 17:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:05 INFO - Downloading/unpacking flake8 17:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:44:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:44:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:44:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:44:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:44:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:44:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:44:08 INFO - no previously-included directories found matching 'docs/_build' 17:44:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:44:08 INFO - Running setup.py install for pep8 17:44:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:44:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:44:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:44:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:44:08 INFO - no previously-included directories found matching 'docs/_build' 17:44:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:44:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:44:08 INFO - Cleaning up... 17:44:09 INFO - Return code: 0 17:44:09 INFO - Running post-action listener: _resource_record_post_action 17:44:09 INFO - Running post-action listener: _start_resource_monitoring 17:44:09 INFO - Starting resource monitoring. 17:44:09 INFO - ##### 17:44:09 INFO - ##### Running install step. 17:44:09 INFO - ##### 17:44:09 INFO - Running pre-action listener: _resource_record_pre_action 17:44:09 INFO - Running main action method: install 17:44:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:09 INFO - Reading from file tmpfile_stdout 17:44:09 INFO - Detecting whether we're running mozinstall >=1.0... 17:44:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:44:09 INFO - Reading from file tmpfile_stdout 17:44:09 INFO - Output received: 17:44:09 INFO - Usage: mozinstall [options] installer 17:44:09 INFO - Options: 17:44:09 INFO - -h, --help show this help message and exit 17:44:09 INFO - -d DEST, --destination=DEST 17:44:09 INFO - Directory to install application into. [default: 17:44:09 INFO - "/builds/slave/test"] 17:44:09 INFO - --app=APP Application being installed. [default: firefox] 17:44:09 INFO - mkdir: /builds/slave/test/build/application 17:44:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:44:25 INFO - Reading from file tmpfile_stdout 17:44:25 INFO - Output received: 17:44:25 INFO - /builds/slave/test/build/application/firefox/firefox 17:44:25 INFO - Running post-action listener: _resource_record_post_action 17:44:25 INFO - ##### 17:44:25 INFO - ##### Running run-tests step. 17:44:25 INFO - ##### 17:44:25 INFO - Running pre-action listener: _resource_record_pre_action 17:44:25 INFO - Running main action method: run_tests 17:44:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:44:25 INFO - Python 2.7.3 17:44:25 INFO - Return code: 0 17:44:25 INFO - grabbing minidump binary from tooltool 17:44:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:44:25 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 0x1049410>, '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 0x104a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:44:25 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 17:44:25 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 17:44:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:44:25 INFO - Return code: 0 17:44:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:44:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:44:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:44:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:44:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:44:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:44:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:44:26 INFO - Return code: 0 17:44:26 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/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 17:44:26 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/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 17:44:26 INFO - Using env: {'DISPLAY': ':0', 17:44:26 INFO - 'HOME': '/home/cltbld', 17:44:26 INFO - 'LANG': 'en_US.UTF-8', 17:44:26 INFO - 'LANGUAGE': 'en_US:en', 17:44:26 INFO - 'LOGNAME': 'cltbld', 17:44:26 INFO - 'MAIL': '/var/mail/cltbld', 17:44:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:44:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:26 INFO - 'MOZ_NO_REMOTE': '1', 17:44:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:26 INFO - 'NO_EM_RESTART': '1', 17:44:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:26 INFO - 'PWD': '/builds/slave/test', 17:44:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:44:26 INFO - 'SHELL': '/bin/bash', 17:44:26 INFO - 'SHLVL': '1', 17:44:26 INFO - 'TERM': 'linux', 17:44:26 INFO - 'TMOUT': '86400', 17:44:26 INFO - 'USER': 'cltbld', 17:44:26 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988', 17:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:26 INFO - '_': '/tools/buildbot/bin/python'} 17:44:26 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/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 17:44:26 INFO - mozversion application_buildid: 20160411160652 17:44:26 INFO - mozversion application_changeset: 4118760a3981d37b7ae31d8c6a9326318e6b3ee8 17:44:26 INFO - mozversion application_display_name: Nightly 17:44:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:44:26 INFO - mozversion application_name: Firefox 17:44:26 INFO - mozversion application_remotingname: firefox 17:44:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:44:26 INFO - mozversion application_vendor: Mozilla 17:44:26 INFO - mozversion application_version: 48.0a1 17:44:26 INFO - mozversion platform_buildid: 20160411160652 17:44:26 INFO - mozversion platform_changeset: 4118760a3981d37b7ae31d8c6a9326318e6b3ee8 17:44:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:44:26 INFO - mozversion platform_version: 48.0a1 17:44:26 INFO - using testdate: 1460421866 17:44:26 INFO - actual date: 1460421866 17:44:26 INFO - starting webserver on 'localhost:53488' 17:44:26 INFO - SUITE-START | Running 2 tests 17:44:26 INFO - TEST-START | dromaeo_css 17:44:26 INFO - operating with platform_type : linux_ 17:44:26 INFO - Initialising browser for dromaeo_css test... 17:44:26 INFO - TEST-INFO | started process 17820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0XDw07/profile http://localhost:53488/getInfo.html) 17:44:30 INFO - PROCESS | 17820 | 17:44:30 INFO - PROCESS | 17820 | (process:17887): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:44:30 INFO - PROCESS | 17820 | 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] 17:44:31 INFO - PROCESS | 17820 | __metrics Screen width/height:1600/1200 17:44:31 INFO - PROCESS | 17820 | colorDepth:24 17:44:31 INFO - PROCESS | 17820 | Browser inner width/height: 1024/697 17:44:31 INFO - PROCESS | 17820 | __metrics 17:44:31 ERROR - PROCESS | 17820 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 17:44:32 INFO - TEST-INFO | 17820: exit 0 17:44:32 INFO - Browser initialized. 17:44:32 INFO - Running cycle 1/1 for dromaeo_css test... 17:44:32 INFO - TEST-INFO | started process 17938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0XDw07/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:34 INFO - PROCESS | 17938 | 17:44:34 INFO - PROCESS | 17938 | (process:17996): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:44:44 INFO - PROCESS | 17938 | RSS: Main: 164532224 17:44:44 INFO - PROCESS | 17938 | 17:45:34 INFO - PROCESS | 17938 | 1460421934291 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] 17:47:46 INFO - PROCESS | 17938 | Cycle 1(1): loaded http://localhost:53488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53488/tests/dromaeo/cssquery-ext.html) 17:47:47 INFO - PROCESS | 17938 | RSS: Main: 169926656 17:47:47 INFO - PROCESS | 17938 | 17:50:49 INFO - PROCESS | 17938 | Cycle 1(1): loaded http://localhost:53488/tests/dromaeo/cssquery-ext.html (next: http://localhost:53488/tests/dromaeo/cssquery-jquery.html) 17:50:49 INFO - PROCESS | 17938 | RSS: Main: 165502976 17:50:49 INFO - PROCESS | 17938 | 17:53:51 INFO - PROCESS | 17938 | Cycle 1(1): loaded http://localhost:53488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53488/tests/dromaeo/cssquery-mootools.html) 17:53:52 INFO - PROCESS | 17938 | RSS: Main: 166875136 17:53:52 INFO - PROCESS | 17938 | 17:56:54 INFO - PROCESS | 17938 | Cycle 1(1): loaded http://localhost:53488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53488/tests/dromaeo/cssquery-prototype.html) 17:56:54 INFO - PROCESS | 17938 | RSS: Main: 164376576 17:56:54 INFO - PROCESS | 17938 | 17:59:57 INFO - PROCESS | 17938 | Cycle 1(1): loaded http://localhost:53488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53488/tests/dromaeo/cssquery-yui.html) 17:59:58 INFO - PROCESS | 17938 | RSS: Main: 165171200 17:59:58 INFO - PROCESS | 17938 | 18:03:00 INFO - PROCESS | 17938 | Cycle 1(1): loaded http://localhost:53488/tests/dromaeo/cssquery-yui.html (next: http://localhost:53488/tests/dromaeo/cssquery-dojo.html) 18:03:00 INFO - PROCESS | 17938 | RSS: Main: 167747584 18:03:00 INFO - PROCESS | 17938 | 18:03:00 INFO - PROCESS | 17938 | __start_tp_report 18:03:00 INFO - PROCESS | 17938 | _x_x_mozilla_page_load 18:03:00 INFO - PROCESS | 17938 | _x_x_mozilla_page_load_details 18:03:00 INFO - PROCESS | 17938 | |i|pagename|runs| 18:03:00 INFO - PROCESS | 17938 | |0;dojo.html;2620.096066856934;2657;2658.920232393029;2670.5860591608293;2686.7313268673124;4564.817407303708;4576.1762882681105;4605.240135377663;4636.953630463694;4660.533946605337;4550.886227844306;4627.676062675614;4667.0665866826685;4670;4749.548792864673;4341.9782901085455;4378.452693413324;4383.539728328527;4449.5995360417555;4482.417285752847;4420.734755914639;4486.259767138418;4501.167284052461;4525.570070843265;4537.455505339364;4215.861717336333;4302.956970430287;4345.869623911288;4435.35687325336;4451.532589078149;4345.97827010863;4348.043430445328;4350.216960947028;4356.912861742748;4382.320740285261;4319.114581510783;4329.740215587043;4335.1329734053315;4344.131173765228;4389.846355377578;4476.462824461086;4480.372747815309;4608.516105808909;4706.364640773486;4715;4988.8752781180765;4998.40019197695;5015.949840501585;5016.247562865563;5066.493350664941;5053.444121146671;5056.721880296583;5066.493350664941;5070.594352451795;5072.010957863218;4609.078184363141;4630.629549636021;4715.339852420664;4741.715497070118;4758.833440829554;5191.143461328914;5194.792208311701;5195;5219.5041471060185;5270;4803.159447096744;4996.825111121166;5002.824901128443;5009;5009.273655319958;4924.556789888928;5077.441481437039;5080.923786143211;5091.694498330112;5123.795048198105;4869.9269510957365;4871.634627402959;4877.609791216765;4881.585065269421;4901.411830580353;4999.175136102503;5008.549230569266;5032;5092.159793634083;5095.286659867622;4334.371516130143;4338.544452832407;4338.934915976263;4350.086481838786;4398.912021759611;3695.796731179757;3714.981425092857;3739.102615372291;3756.098536351256;3784.905377365588;4360.106178233455;4383.3424986251675;4402.823887044547;4435.334699795057;4443.777811109431;4948.529889660476;5066.240063990431;5072.746362681851;5077.162268225775;5081.720505372166;4362.650987920959;4399.472063352418;4400.22995975703;4412.911741765147;4434;4585.839495617704;4612.123696497655;4632.814687412533;4651.139539185194;4681.461631912305;4731.905361892812;4733.266343716729;4780.1873681473535;4798.616110711135;4821.325014497973;5076.18780995039;5085.745712714275;5086.262491938722;5103.8468845934685;5160.819371321985;4766.737829419415;4794.256890182028;4805.159097158054;4807.230843065093;4839.080574690797;4881.975590122169;4964.875878102932;4985.775640096277;5013.2981382607195;5049.116404629249;4972.204447288416;5027.874303142451;5029.698218106925;5057.5195356442555;5084.567811735896;4847.781849816696;4849.442314133919;4865.245886887538;4866.853994380174;4917.188663870565;4753.619710423227;4811.855644330676;4865.6107511398295;4895.485973972682;4910.116179087799;4719.3628860103445;4768.403949506312;4785.090832741768;4831.589314908272;4835.129676658235;4878.487758785276;4881.51184881509;4913.312136300992;4931.654784165074;4976.029674213493;4729.43246810385;4784.736839473862;4852.296417019583;4855.951440485691;4881.51184881509 18:03:00 INFO - PROCESS | 17938 | |1;ext.html;560.553633217993;576.2767726503239;591.3849596419724;604.5103466192384;614.1678026274401;35443;36941.44587831181;36992.44511332326;37042.44436333451;37114.62885371145;37997.43003854938;38451.42322865159;38622;38675.41986870199;38680.80659596705;7713.922860771377;7869.291763741262;7871.094824095217;7900.170482099383;7935.325497332734;7714.151443341228;7808.570528620923;7821.21787821219;7867.685292588319;7869.331106855924;7653.693852245903;7710.845783084335;7714.575698336589;7716.382689384835;7721.073471183466;7635.885461718079;7641.1976742442075;7673.577953212571;7681.270279323483;7687.577183254919;7985.480943738638;8085.3127484163915;8090.312323452514;8090.797730056737;8116.6347514362;30922;37171.442428363596;37614;37939.62060379388;38113.42829857554;2845;2867.5125228711167;2878.928026799326;2882.654081510232;3311.536384906115;24668.259952201464;24873.378165545826;24877.751222487906;24975.5004899901;25367.238982830546;3027.197792584967;3209.9197520062185;3278.2623909620384;3315.900522984314;3332.0836769888233;152977;153653;154160.22919885442;154612.2269388646;155028;32764;33040.83479582635;33044.66955330464;33101.33797324088;33189.83405082959;33705.83147084298;33795.493067604;48167.869088509135;49786.50213497891;49988.500114999115;13839.861601384058;14013.789793153112;14042.578722638336;14045.367958441895;14123.646908827155;10213.33613315132;10264.384136951807;10315.12321452685;10329.586816527404;10332.741681457874;19048.238070477026;19075.90462047681;19208.327708530134;19243;19269.710954335696;6827.453803695693;6871.5189936703955;7001.964990175016;7062.505624606229;7228.963855180796;795.562440657636;861.1603686405705;878.6090189865448;934.9205317548085;999.8900120986685;24590.877045614656;25450;25786.226413207634;25936;26134.73865261361;979.9657012004689;992.1071036067597;996.4490903287607;1005.9798804023878;1012.2661070723666;14078.084924480081;14475.638109047148;14601.269936503133;14637.414503419745;14785.704285914222;342836;349621;350125;350926;351285;39618.603813962065;40146.19707605831;40172;40258.39612405816;40309.984500774844;1192.272713644676;1205.0901569315286;1206.5535751772077;1233.648410203088;1244.2410129820803;25132.62301065522;26218.475630487665;26435.867820660773;26496.470070598094;26577.867110664323;40348.79825600853;41175.58824411718;41234.79382603068;41354;41461.79269103635;305269;306597;307344;308277;308842;25613.615795762707;38789.6121038786;39579.2084158321;39902.20195596014;40252.79873600613;39233.60766392414;40601.593984060964;40686;40910.38634420546;41221.38167927424;35301.47047794234;35530.28939421249;35940;36043.81978090198;36131.63868361283;33969.830150849084;34296.314073717884;34379;34887.127821803646;34887.476687849194;30730.38539229158;35530.46704299489;35754.64245357513;36861;38060.42909356306;31348.843255783577;32167.839160804047;32220.677793221766;32370;32406.83796581002;24792.504149917262;25468;25504.617430738926;25711.614325784754;25811 18:03:00 INFO - PROCESS | 17938 | |2;jquery.html;363.394947412558;366.4649611567112;367.1518791591424;369.7836765492187;377.83941824724485;15513;15763.211839408026;16617.335306587753;16638.916805415985;16687.66624667506;15124.848751512482;16512.25694843732;16579.25393357299;16641;16666.66666666666;4393.450818647669;4637.0725854829;4690.4605970313505;4700.459447163568;4703.553162449562;4541.364209010741;4580.862574122765;4632.745199014053;4643.55886190813;4790.329353890458;4760.071786001731;4761.47623761386;4775.737334446604;4797.9520204797855;4799.592034677056;4648.930266046012;4776.928346074795;4789.928151077719;4802.543758342969;4849.563539281482;4747.643926705511;4749.121412538691;4753.857384278443;4754.786034628415;4755.476897541268;12290.324032178227;12564.623061308175;15738.291776870068;20580.176792928265;20614.690779638317;1786.901720405377;1972.615340008699;2194.6817711431754;2274.283600665785;2328.580855446019;8414.663413463453;9174.311926605464;9409.200217981479;9625.90374096257;9630.229581633452;1764.6647137043922;1778.5820332221917;1830.6155707301482;1841.3647291684347;1857.3406440713488;53186.73406632942;64044.41235778844;70182.29817701809;70420.29579704188;72059;9823.508824558887;9944.1547468466;10096.14182794456;10220.897791022144;10343.844842327371;14245.43018279278;14309.427622894967;14355.425782968774;14366.712665746836;14402.567922962327;7240.312170343809;7253.202147763742;7315.817104572428;7340.486165968331;7476.663550140257;6614.404703576702;6713.227978782503;6791.490638202055;6832.111825462658;7041.859162816715;4347.999960009152;4355.499117601453;4384.12317536494;4384.430024096847;4404.8458303959205;1748.8688348373923;1788.65121301345;1795.9640807183782;1809.683305421546;1848.1498510685235;974.8196583632051;993.3841018568534;993.7018894331671;1008.742770593494;1014.077189757332;16112.838871611368;16181.110038947736;16541.6691666166;16625.168741562873;16884.831151688573;860.2000139869981;873.8601823708176;904.2494729374604;940.6096469965024;941.580996456584;9013.414128081653;9202.90797092034;9295.72112836616;9545.856812147824;9559.713208603753;372996;381065;384391;388976;389146;75850.24149758542;79054.20945790583;79739.60130199311;79945.60027199826;80365;811.3914564076942;918.0452329577298;958.6596758150896;976.2824324121765;979.5445118020154;13013.47946082184;13387.598372048855;14888.478903238334;15135.924320378768;15147.469838555598;32016;32430.513542296412;32705.836470817492;32780.50829237611;33314.16714582155;40822.38766418447;46212.53787462082;46394;46543.767281164735;47180.292295614905;7584.734534291273;7794.571298578632;7820.139784623573;7858.371330293677;8175.7138500152205;8743.562821858754;10920.672379828618;11560.248583842023;11620.356538193677;11635.825462617899;10084.092431681183;10105.459026372168;10119.494025298853;10289.74275643115;10569.577216911237;9533.61865525399;9879.407235565888;9992.250581206294;10129.493525323556;10431.739206519898;9707.805843883225;9855.408675479493;10479.318844275098;10697.518611662339;10790.298630588986;7996.04047514302;8024.759257222293;8039.075506316848;8143.470674406145;8176.182381761776;9817.705468835946;10005.099541041342;10046.844612869614;10304.175665946856;10624.468776561296 18:03:00 INFO - PROCESS | 17938 | |3;mootools.html;1408.4718230663498;1421.3177674716137;1546.7679848022794;1703.8977661340314;1723.2159367487786;6610.438112760421;7153.213146553875;7414.406847452205;7448.180700122982;7468.066491688545;7254.854902901952;7317;7344.228855970113;7380.926190738091;7407.814804629874;2218.6561083032157;2247.4830788918557;2262.332611879491;2264.762199969004;2266.0256089881345;2241.4508445430893;2249.853759505635;2258.774122587736;2282.3609389371004;2282.99548198792;2222.1333679864783;2251.6960210371553;2255.560165767676;2259.9887000565054;2273.5680220758086;2218.7004754358277;2223.110755697726;2236.586231547169;2253.312739614417;2256.311824893407;2159.2010955946243;2166.42589713726;2167.5448155887284;2169.4467910682674;2173.967390489144;7656.0812702475505;7658.310752032344;7690.384769218449;7736.342410895025;7740.225977402271;4483.439570053743;4613.261878099522;4618.515055919113;4646.326282689025;4672.836450724242;2934.1344303430537;3075.9846200769075;3076.8769249230004;3095.9845200773852;3117.283024904262;1822.1526989949737;1847.2703282203454;1849.824266694662;1869.8597605179666;1877.6995680691161;10405.947970260177;10572.629957951434;10575.682729518127;10601.78796424075;10602.734931626694;4054.2296963576828;4105.3020986432375;4262.957370426318;4270.145970805851;4307.978460107679;8358.45670031446;8376.623051962677;8395.664173432995;8433.536155511383;8462.407631465861;4578.198815207392;4638.628909687217;4638.698484598491;4641.071785642817;4661.813527458864;3726.9068273293383;4132.194222126656;4229.090745489734;4278.72188307759;4324.805383757738;3428.3143371325336;3457.4122399192197;3551.485034669958;3567.4292113261754;3605.260921511084;1020.3112898793285;1023.2274632652449;1028.1774580335702;1029.8249297619423;1070.9410982396043;1185.4191446191305;1208.9274643521417;1213.836132122152;1231.1012960538858;1237.4431505822415;7192.244814294529;7227.710891564384;7314.96342518284;7354.742584009641;7447.3669738071785;448.26260800982203;456.8880624247081;468.43319583304583;468.43553518010714;469.6900045969712;5761.366249712528;5792.218050563204;5821.650700957956;5851.093080572518;5883.411658834168;8619.569021548898;9558.617655293849;9611;9613.327067105236;9670.129688328085;9342.48616326095;9433.433993960385;9585.137337639646;9613.182879455184;9634.855477167708;7182.42540596751;7272.272772722791;7341.119065712149;7351.926480735231;7382.077240345065;6900;7081.114860642419;7115.181754098138;7130.465215108784;7166.964165179141;8656.0478347383;8733.65065397377;8894.332925030778;8905.599248033983;8963.686270980485;8607.397482176188;8856.114388561093;9016.549172541478;9178.954105229432;9248.306377021885;5763;6101.633901965896;6364.490840732823;6374.74501019954;6383.329750376143;7119.181294151239;7171.175314838861;7191.460640452092;7191.964040179975;7199.1361036675935;6251.180358829157;6321.5258855586935;6362.77730279438;6458.967705161632;6467.741290348522;6488.643124628191;6631.204255489372;6639.4688424924925;6646.401823835878;6672.599644021374;7047.577145371294;7054;7060.188078371053;7098.538594991309;7115.217326094229;6391.169148010729;6403.551751377545;6444.065610486359;6453.967730161319;6468.288488266381;6239.875202495834;6240.438360547572;6241.750329986749;6268.529860260407;6286.497080233479 18:03:00 INFO - PROCESS | 17938 | |4;prototype.html;293.591907248924;296.57145424861073;296.6632871690632;306.9401466713992;312.79355625287315;5186.1442861927735;5258.973705131474;5271.630985830989;5274.683518988863;5283;5178.352705911761;5219.895602087956;5220.373555173375;5220.686758794475;5231.163013917764;3812.3519001769764;3894.279558281713;4051.6150965658217;4058.3912413138046;4065.857694980676;4027.3354896442197;4051.0427388006774;4077.7349472284354;4079.2861249281405;4089.5501494835694;3988.282109220339;3997.5602683704915;4015.8996025099314;4022.235775202702;4032.9395059074136;3845.692344612424;4037.051292946155;4045.8988525286954;4046.615571520701;4046.8381264749373;3562.3765840977985;3568.83940222688;3579.266250418658;3594.946075808865;3606.4229723244157;4967.428745694219;4969.180085285923;4973.204287314049;4974.079795237856;5014.24786282057;4564.977175114136;4627.3521706961055;4687.7656117194;4687.929681054787;4700.976495117537;5470.9452905470835;5471.753771080311;5514.889702205974;5538.529225015878;5539.670479085031;3928.4303775952326;3932.6067393260732;3933.7836418996944;3945.506811648544;3953.5651078381356;5606.747696353674;5724.853180057478;5794;5809.758876020529;5829.387914268983;4036.495438070241;4039.8990025249605;4044.170944956336;4052.2300762855552;4061.918761624751;4101.85643502476;4103.630673239423;4106.1582375612925;4108.856190033394;4118.114605359862;4669.252919532926;4681.81272749093;4690.9765451172525;4697.647676424282;4698.154332220233;5249.868753281198;5500.779968801203;5552.833414997556;5559.63862348946;5578.86052848682;1414.130309859429;1429.7061159650532;1433.8924580656285;1435.3038776193537;1445.3134760988446;900.9234215091659;952.5665822050951;962.0860182826203;989.8762654668167;991.7768502086973;4734.905301893943;4866.221404575251;4867.829625963145;4901.50984901507;4902.166631672553;5702.942970570324;5714.371419143891;5719.370869204384;5745.511631511368;5801.274840644919;4797.928031079537;4877.95122048775;4889.926651100236;4898.363212782387;4917.729524876167;3045.482268014443;3062.2038270049948;3065.8196594311353;3085.783995120365;3101.3332133591384;5414.214938833847;5422.8915421691345;5423.322084739408;5430.294061771944;5442.482964118402;5681.318241810926;5885.793997210077;5901.557383196277;5907.261592300963;5914.260717410324;5359.919601205985;5381.13901775714;5387.919181212285;5391.191321301758;5411.83764487066;5514.834554963358;5692.4876761090045;5721.399253078367;5749.13762935563;5764;5539.723013849372;5543.584231182758;5561.136014952222;5601.467860553241;5606.495415412633;5385.9192112119135;5392.973035134799;5396.379416367011;5400.540954018952;5414.242006119225;3986.0034991252187;4039.272930872471;4058.159288498004;4058.7158898876796;4083.122128742216;5613.158026296088;5663.150527420919;5694.316681998187;5725.427457254241;5746.367899531132;5492.697901615449;5514.751836167462;5520.475554822286;5538.335399752055;5566.972165139148;5217.269582258411;5546.972265138648;5559.499645031967;5600.187972744011;5615.3823079462045;5421.701806400686;5440.292761940922;5470.468268884719;5473.675796121179;5499.917501237404;5305.893882122413;5381.165919282517;5578.246936663499;5586.636868603528;5595.804146854841;5393.784248630011;5422.15956526739;5429.728513574227;5436.429174936575;5437.184422336523 18:03:00 INFO - PROCESS | 17938 | |5;yui.html;648.7891435283528;699.4044674831331;712.6686090967701;740;744.6031185847569;12297.200681955666;12665.303408312539;12716.491340346374;12761.553345632881;12765.808512872314;11139.275947063436;11277.097832173427;11278.15413843961;11287.322760634348;11311.943440282808;649.3538928765885;779.9766007019798;794.6622685358714;806.4717609965483;811.7645882694042;640.69887153038;645.8094862015694;647.0359164844372;648.1056142523312;648.264220110176;852.4885068958637;853.5518852602403;855.7347222361088;856.0882659967147;857.9914200857974;845.1337379186322;848.7920459487403;849.9235068843802;851.7231899632613;852.0414533649645;620.1318154583574;623.8627501949563;625.1123404765244;625.8685676008043;626.5081910700125;12050.819237711441;12089.335086570236;12105.09211809118;12116.636500904988;12145.939270303592;12573.182743121668;12630.873691263061;12702.174358666656;12931.030172736988;12977.091603587753;9567.282453815922;9781.364211326241;9807.215422766161;9987.900120998842;9996.250281228864;3288.786228895114;3322.983385083059;3335.299587086715;3372.291818718072;3395.456726923705;46906.530934690556;47044.29433558499;47186.8203294917;48054.279185812244;48435.757821211024;10267.281290309757;10271.332363396505;10285.74285642865;10398.58405663765;10615.84076238857;17945.371911983017;17965.281388744566;17981.550461238574;18011.639767204582;18583.628327433376;6573.80278591643;6713;6772.492063095287;6985.301469852974;7097.964510177416;3539.345221134098;3578.141246100917;3630.3465376232;3663.120850995742;3705.314516814344;2836.290927268183;2930.1502564256125;2933.1054028521507;2943.249471384826;2944.1903476543694;501.15305134322875;503.94456609772897;507.91619382801423;509.8725318670332;512.8948565544055;536.8094326514031;557.3785229469194;609.2354095609982;621.0621960839165;621.6083867163658;7683.346915512132;7689.692412303445;7697.4226932980255;7910.406719496061;7929.852451686645;453.5688708522383;550.8099705601561;591.9496842768327;609.6585911889356;614.4838335797951;3593.3531964246686;3903.9609603903596;3904.511936007999;3946.3883098119836;3969.6824254059607;49208.753956229986;49496.75251623719;49526.75236623794;49585.75207124013;50568.49431505711;43370.78314608407;43511.12977740491;43658.12683746371;43777.56222437799;45235.32147017797;39995;40601;40921.590784092376;41063.58936410657;42320;7277.2722727726805;7347.55914645123;7499.5875226863045;7700.114486834086;7764.805879853049;26405.471890562465;26570.202893913214;27026.054088106823;27131.72868271292;27356.179314620593;32481.35037299288;33618.15100169514;34643.30713385668;34995;35441.29117417586;10792.136629069813;10844.67465976022;10935.125189984623;11126.777464450828;11162.107031437628;11914.225575337576;11962.521499139937;12122.151449398458;12164;12302.384880756106;9434.245260379015;9482.810343793224;9902.950485247527;9931.602735890483;10627.628033018807;10773.299735517166;11646.24299420535;11768;11789.587364442203;12049.33728644933;9596.040395960348;10392.636257730943;10954.890451095705;10970.23208375438;11355.886441135483;9119.544022798966;9478.57346419399;9557.761055973657;9705;9800.607975680892;9315.6273749052;9355.578998944928;9559.522023898917;9878.555465004236;9973.950130249303 18:03:00 INFO - PROCESS | 17938 | __end_tp_report 18:03:00 INFO - PROCESS | 17938 | __start_cc_report 18:03:00 INFO - PROCESS | 17938 | _x_x_mozilla_cycle_collect,377 18:03:00 INFO - PROCESS | 17938 | __end_cc_report 18:03:00 INFO - PROCESS | 17938 | __startTimestamp1460422980823__endTimestamp 18:03:00 INFO - PROCESS | 17938 | 18:03:00 INFO - PROCESS | 17938 | ------- Summary: start ------- 18:03:00 INFO - PROCESS | 17938 | Number of tests: 6 18:03:00 INFO - PROCESS | 17938 | 18:03:00 INFO - PROCESS | 17938 | [#0] dojo.html Cycles:165 Average:4664.19 Median:4780.19 stddev:474.89 (9.9%) stddev-sans-first:448.45 18:03:00 INFO - PROCESS | 17938 | Values: 2620.1 2657.0 2658.9 2670.6 2686.7 4564.8 4576.2 4605.2 4637.0 4660.5 4550.9 4627.7 4667.1 4670.0 4749.5 4342.0 4378.5 4383.5 4449.6 4482.4 4420.7 4486.3 4501.2 4525.6 4537.5 4215.9 4303.0 4345.9 4435.4 4451.5 4346.0 4348.0 4350.2 4356.9 4382.3 4319.1 4329.7 4335.1 4344.1 4389.8 4476.5 4480.4 4608.5 4706.4 4715.0 4988.9 4998.4 5015.9 5016.2 5066.5 5053.4 5056.7 5066.5 5070.6 5072.0 4609.1 4630.6 4715.3 4741.7 4758.8 5191.1 5194.8 5195.0 5219.5 5270.0 4803.2 4996.8 5002.8 5009.0 5009.3 4924.6 5077.4 5080.9 5091.7 5123.8 4869.9 4871.6 4877.6 4881.6 4901.4 4999.2 5008.5 5032.0 5092.2 5095.3 4334.4 4338.5 4338.9 4350.1 4398.9 3695.8 3715.0 3739.1 3756.1 3784.9 4360.1 4383.3 4402.8 4435.3 4443.8 4948.5 5066.2 5072.7 5077.2 5081.7 4362.7 4399.5 4400.2 4412.9 4434.0 4585.8 4612.1 4632.8 4651.1 4681.5 4731.9 4733.3 4780.2 4798.6 4821.3 5076.2 5085.7 5086.3 5103.8 5160.8 4766.7 4794.3 4805.2 4807.2 4839.1 4882.0 4964.9 4985.8 5013.3 5049.1 4972.2 5027.9 5029.7 5057.5 5084.6 4847.8 4849.4 4865.2 4866.9 4917.2 4753.6 4811.9 4865.6 4895.5 4910.1 4719.4 4768.4 4785.1 4831.6 4835.1 4878.5 4881.5 4913.3 4931.7 4976.0 4729.4 4784.7 4852.3 4856.0 4881.5 18:03:00 INFO - PROCESS | 17938 | 18:03:00 INFO - PROCESS | 17938 | [#1] ext.html Cycles:180 Average:41957.24 Median:351105.50 stddev:74497.68 (21.2%) stddev-sans-first:74641.83 18:03:00 INFO - PROCESS | 17938 | Values: 560.6 576.3 591.4 604.5 614.2 35443.0 36941.4 36992.4 37042.4 37114.6 37997.4 38451.4 38622.0 38675.4 38680.8 7713.9 7869.3 7871.1 7900.2 7935.3 7714.2 7808.6 7821.2 7867.7 7869.3 7653.7 7710.8 7714.6 7716.4 7721.1 7635.9 7641.2 7673.6 7681.3 7687.6 7985.5 8085.3 8090.3 8090.8 8116.6 30922.0 37171.4 37614.0 37939.6 38113.4 2845.0 2867.5 2878.9 2882.7 3311.5 24668.3 24873.4 24877.8 24975.5 25367.2 3027.2 3209.9 3278.3 3315.9 3332.1 152977.0 153653.0 154160.2 154612.2 155028.0 32764.0 33040.8 33044.7 33101.3 33189.8 33705.8 33795.5 48167.9 49786.5 49988.5 13839.9 14013.8 14042.6 14045.4 14123.6 10213.3 10264.4 10315.1 10329.6 10332.7 19048.2 19075.9 19208.3 19243.0 19269.7 6827.5 6871.5 7002.0 7062.5 7229.0 795.6 861.2 878.6 934.9 999.9 24590.9 25450.0 25786.2 25936.0 26134.7 980.0 992.1 996.4 1006.0 1012.3 14078.1 14475.6 14601.3 14637.4 14785.7 342836.0 349621.0 350125.0 350926.0 351285.0 39618.6 40146.2 40172.0 40258.4 40310.0 1192.3 1205.1 1206.6 1233.6 1244.2 25132.6 26218.5 26435.9 26496.5 26577.9 40348.8 41175.6 41234.8 41354.0 41461.8 305269.0 306597.0 307344.0 308277.0 308842.0 25613.6 38789.6 39579.2 39902.2 40252.8 39233.6 40601.6 40686.0 40910.4 41221.4 35301.5 35530.3 35940.0 36043.8 36131.6 33969.8 34296.3 34379.0 34887.1 34887.5 30730.4 35530.5 35754.6 36861.0 38060.4 31348.8 32167.8 32220.7 32370.0 32406.8 24792.5 25468.0 25504.6 25711.6 25811.0 18:03:00 INFO - PROCESS | 17938 | 18:03:00 INFO - PROCESS | 17938 | [#2] jquery.html Cycles:180 Average:23543.10 Median:4561.11 stddev:63304.03 (1387.9%) stddev-sans-first:63457.69 18:03:00 INFO - PROCESS | 17938 | Values: 363.4 366.5 367.2 369.8 377.8 15513.0 15763.2 16617.3 16638.9 16687.7 15124.8 16512.3 16579.3 16641.0 16666.7 4393.5 4637.1 4690.5 4700.5 4703.6 4541.4 4580.9 4632.7 4643.6 4790.3 4760.1 4761.5 4775.7 4798.0 4799.6 4648.9 4776.9 4789.9 4802.5 4849.6 4747.6 4749.1 4753.9 4754.8 4755.5 12290.3 12564.6 15738.3 20580.2 20614.7 1786.9 1972.6 2194.7 2274.3 2328.6 8414.7 9174.3 9409.2 9625.9 9630.2 1764.7 1778.6 1830.6 1841.4 1857.3 53186.7 64044.4 70182.3 70420.3 72059.0 9823.5 9944.2 10096.1 10220.9 10343.8 14245.4 14309.4 14355.4 14366.7 14402.6 7240.3 7253.2 7315.8 7340.5 7476.7 6614.4 6713.2 6791.5 6832.1 7041.9 4348.0 4355.5 4384.1 4384.4 4404.8 1748.9 1788.7 1796.0 1809.7 1848.1 974.8 993.4 993.7 1008.7 1014.1 16112.8 16181.1 16541.7 16625.2 16884.8 860.2 873.9 904.2 940.6 941.6 9013.4 9202.9 9295.7 9545.9 9559.7 372996.0 381065.0 384391.0 388976.0 389146.0 75850.2 79054.2 79739.6 79945.6 80365.0 811.4 918.0 958.7 976.3 979.5 13013.5 13387.6 14888.5 15135.9 15147.5 32016.0 32430.5 32705.8 32780.5 33314.2 40822.4 46212.5 46394.0 46543.8 47180.3 7584.7 7794.6 7820.1 7858.4 8175.7 8743.6 10920.7 11560.2 11620.4 11635.8 10084.1 10105.5 10119.5 10289.7 10569.6 9533.6 9879.4 9992.3 10129.5 10431.7 9707.8 9855.4 10479.3 10697.5 10790.3 7996.0 8024.8 8039.1 8143.5 8176.2 9817.7 10005.1 10046.8 10304.2 10624.5 18:03:00 INFO - PROCESS | 17938 | 18:03:00 INFO - PROCESS | 17938 | [#3] mootools.html Cycles:180 Average:5362.68 Median:5992.52 stddev:2790.77 (46.6%) stddev-sans-first:2782.77 18:03:00 INFO - PROCESS | 17938 | Values: 1408.5 1421.3 1546.8 1703.9 1723.2 6610.4 7153.2 7414.4 7448.2 7468.1 7254.9 7317.0 7344.2 7380.9 7407.8 2218.7 2247.5 2262.3 2264.8 2266.0 2241.5 2249.9 2258.8 2282.4 2283.0 2222.1 2251.7 2255.6 2260.0 2273.6 2218.7 2223.1 2236.6 2253.3 2256.3 2159.2 2166.4 2167.5 2169.4 2174.0 7656.1 7658.3 7690.4 7736.3 7740.2 4483.4 4613.3 4618.5 4646.3 4672.8 2934.1 3076.0 3076.9 3096.0 3117.3 1822.2 1847.3 1849.8 1869.9 1877.7 10405.9 10572.6 10575.7 10601.8 10602.7 4054.2 4105.3 4263.0 4270.1 4308.0 8358.5 8376.6 8395.7 8433.5 8462.4 4578.2 4638.6 4638.7 4641.1 4661.8 3726.9 4132.2 4229.1 4278.7 4324.8 3428.3 3457.4 3551.5 3567.4 3605.3 1020.3 1023.2 1028.2 1029.8 1070.9 1185.4 1208.9 1213.8 1231.1 1237.4 7192.2 7227.7 7315.0 7354.7 7447.4 448.3 456.9 468.4 468.4 469.7 5761.4 5792.2 5821.7 5851.1 5883.4 8619.6 9558.6 9611.0 9613.3 9670.1 9342.5 9433.4 9585.1 9613.2 9634.9 7182.4 7272.3 7341.1 7351.9 7382.1 6900.0 7081.1 7115.2 7130.5 7167.0 8656.0 8733.7 8894.3 8905.6 8963.7 8607.4 8856.1 9016.5 9179.0 9248.3 5763.0 6101.6 6364.5 6374.7 6383.3 7119.2 7171.2 7191.5 7192.0 7199.1 6251.2 6321.5 6362.8 6459.0 6467.7 6488.6 6631.2 6639.5 6646.4 6672.6 7047.6 7054.0 7060.2 7098.5 7115.2 6391.2 6403.6 6444.1 6454.0 6468.3 6239.9 6240.4 6241.8 6268.5 6286.5 18:03:00 INFO - PROCESS | 17938 | 18:03:00 INFO - PROCESS | 17938 | [#4] prototype.html Cycles:180 Average:4582.62 Median:5225.92 stddev:1336.78 (25.6%) stddev-sans-first:1301.19 18:03:00 INFO - PROCESS | 17938 | Values: 293.6 296.6 296.7 306.9 312.8 5186.1 5259.0 5271.6 5274.7 5283.0 5178.4 5219.9 5220.4 5220.7 5231.2 3812.4 3894.3 4051.6 4058.4 4065.9 4027.3 4051.0 4077.7 4079.3 4089.6 3988.3 3997.6 4015.9 4022.2 4032.9 3845.7 4037.1 4045.9 4046.6 4046.8 3562.4 3568.8 3579.3 3594.9 3606.4 4967.4 4969.2 4973.2 4974.1 5014.2 4565.0 4627.4 4687.8 4687.9 4701.0 5470.9 5471.8 5514.9 5538.5 5539.7 3928.4 3932.6 3933.8 3945.5 3953.6 5606.7 5724.9 5794.0 5809.8 5829.4 4036.5 4039.9 4044.2 4052.2 4061.9 4101.9 4103.6 4106.2 4108.9 4118.1 4669.3 4681.8 4691.0 4697.6 4698.2 5249.9 5500.8 5552.8 5559.6 5578.9 1414.1 1429.7 1433.9 1435.3 1445.3 900.9 952.6 962.1 989.9 991.8 4734.9 4866.2 4867.8 4901.5 4902.2 5702.9 5714.4 5719.4 5745.5 5801.3 4797.9 4878.0 4889.9 4898.4 4917.7 3045.5 3062.2 3065.8 3085.8 3101.3 5414.2 5422.9 5423.3 5430.3 5442.5 5681.3 5885.8 5901.6 5907.3 5914.3 5359.9 5381.1 5387.9 5391.2 5411.8 5514.8 5692.5 5721.4 5749.1 5764.0 5539.7 5543.6 5561.1 5601.5 5606.5 5385.9 5393.0 5396.4 5400.5 5414.2 3986.0 4039.3 4058.2 4058.7 4083.1 5613.2 5663.2 5694.3 5725.4 5746.4 5492.7 5514.8 5520.5 5538.3 5567.0 5217.3 5547.0 5559.5 5600.2 5615.4 5421.7 5440.3 5470.5 5473.7 5499.9 5305.9 5381.2 5578.2 5586.6 5595.8 5393.8 5422.2 5429.7 5436.4 5437.2 18:03:00 INFO - PROCESS | 17938 | 18:03:00 INFO - PROCESS | 17938 | [#5] yui.html Cycles:180 Average:12406.20 Median:23680.05 stddev:13814.14 (58.3%) stddev-sans-first:13824.67 18:03:00 INFO - PROCESS | 17938 | Values: 648.8 699.4 712.7 740.0 744.6 12297.2 12665.3 12716.5 12761.6 12765.8 11139.3 11277.1 11278.2 11287.3 11311.9 649.4 780.0 794.7 806.5 811.8 640.7 645.8 647.0 648.1 648.3 852.5 853.6 855.7 856.1 858.0 845.1 848.8 849.9 851.7 852.0 620.1 623.9 625.1 625.9 626.5 12050.8 12089.3 12105.1 12116.6 12145.9 12573.2 12630.9 12702.2 12931.0 12977.1 9567.3 9781.4 9807.2 9987.9 9996.3 3288.8 3323.0 3335.3 3372.3 3395.5 46906.5 47044.3 47186.8 48054.3 48435.8 10267.3 10271.3 10285.7 10398.6 10615.8 17945.4 17965.3 17981.6 18011.6 18583.6 6573.8 6713.0 6772.5 6985.3 7098.0 3539.3 3578.1 3630.3 3663.1 3705.3 2836.3 2930.2 2933.1 2943.2 2944.2 501.2 503.9 507.9 509.9 512.9 536.8 557.4 609.2 621.1 621.6 7683.3 7689.7 7697.4 7910.4 7929.9 453.6 550.8 591.9 609.7 614.5 3593.4 3904.0 3904.5 3946.4 3969.7 49208.8 49496.8 49526.8 49585.8 50568.5 43370.8 43511.1 43658.1 43777.6 45235.3 39995.0 40601.0 40921.6 41063.6 42320.0 7277.3 7347.6 7499.6 7700.1 7764.8 26405.5 26570.2 27026.1 27131.7 27356.2 32481.4 33618.2 34643.3 34995.0 35441.3 10792.1 10844.7 10935.1 11126.8 11162.1 11914.2 11962.5 12122.2 12164.0 12302.4 9434.2 9482.8 9903.0 9931.6 10627.6 10773.3 11646.2 11768.0 11789.6 12049.3 9596.0 10392.6 10954.9 10970.2 11355.9 9119.5 9478.6 9557.8 9705.0 9800.6 9315.6 9355.6 9559.5 9878.6 9974.0 18:03:00 INFO - PROCESS | 17938 | -------- Summary: end -------- 18:03:00 INFO - PROCESS | 17938 | 18:03:01 INFO - TEST-INFO | 17938: exit 0 18:03:01 INFO - TEST-OK | dromaeo_css | took 1115053ms 18:03:01 INFO - TEST-START | kraken 18:03:01 INFO - operating with platform_type : linux_ 18:03:01 INFO - Initialising browser for kraken test... 18:03:01 INFO - TEST-INFO | started process 18169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnssFHR/profile http://localhost:53488/getInfo.html) 18:03:05 INFO - PROCESS | 18169 | 18:03:05 INFO - PROCESS | 18169 | (process:18235): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:03:05 INFO - PROCESS | 18169 | 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] 18:03:05 INFO - PROCESS | 18169 | __metrics Screen width/height:1600/1200 18:03:05 INFO - PROCESS | 18169 | colorDepth:24 18:03:05 INFO - PROCESS | 18169 | Browser inner width/height: 1024/697 18:03:05 INFO - PROCESS | 18169 | __metrics 18:03:06 ERROR - PROCESS | 18169 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 18:03:07 INFO - TEST-INFO | 18169: exit 0 18:03:07 INFO - Browser initialized. 18:03:07 INFO - Running cycle 1/1 for kraken test... 18:03:07 INFO - TEST-INFO | started process 18286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnssFHR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:09 INFO - PROCESS | 18286 | 18:03:09 INFO - PROCESS | 18286 | (process:18346): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:03:19 INFO - PROCESS | 18286 | RSS: Main: 164667392 18:03:19 INFO - PROCESS | 18286 | 18:03:21 INFO - PROCESS | 18286 | Cycle 1(1): loaded http://localhost:53488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53488/tests/kraken/driver.html?testName=audio-beat-detection) 18:03:22 INFO - PROCESS | 18286 | RSS: Main: 168779776 18:03:22 INFO - PROCESS | 18286 | 18:03:25 INFO - PROCESS | 18286 | Cycle 1(1): loaded http://localhost:53488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53488/tests/kraken/driver.html?testName=audio-dft) 18:03:26 INFO - PROCESS | 18286 | RSS: Main: 172150784 18:03:26 INFO - PROCESS | 18286 | 18:03:29 INFO - PROCESS | 18286 | Cycle 1(1): loaded http://localhost:53488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53488/tests/kraken/driver.html?testName=audio-fft) 18:03:29 INFO - PROCESS | 18286 | RSS: Main: 162754560 18:03:29 INFO - PROCESS | 18286 | 18:03:31 INFO - PROCESS | 18286 | Cycle 1(1): loaded http://localhost:53488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53488/tests/kraken/driver.html?testName=audio-oscillator) 18:03:32 INFO - PROCESS | 18286 | RSS: Main: 163434496 18:03:32 INFO - PROCESS | 18286 | 18:03:34 INFO - PROCESS | 18286 | Cycle 1(1): loaded http://localhost:53488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:03:35 INFO - PROCESS | 18286 | RSS: Main: 164626432 18:03:35 INFO - PROCESS | 18286 | 18:03:38 INFO - PROCESS | 18286 | Cycle 1(1): loaded http://localhost:53488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53488/tests/kraken/driver.html?testName=imaging-darkroom) 18:03:39 INFO - PROCESS | 18286 | RSS: Main: 164634624 18:03:39 INFO - PROCESS | 18286 | 18:03:42 INFO - PROCESS | 18286 | Cycle 1(1): loaded http://localhost:53488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53488/tests/kraken/driver.html?testName=imaging-desaturate) 18:03:43 INFO - PROCESS | 18286 | RSS: Main: 164433920 18:03:43 INFO - PROCESS | 18286 | 18:03:46 INFO - PROCESS | 18286 | Cycle 1(1): loaded http://localhost:53488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53488/tests/kraken/driver.html?testName=json-parse-financial) 18:03:46 INFO - PROCESS | 18286 | RSS: Main: 164798464 18:03:46 INFO - PROCESS | 18286 | 18:03:48 INFO - PROCESS | 18286 | Cycle 1(1): loaded http://localhost:53488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:03:49 INFO - PROCESS | 18286 | RSS: Main: 165142528 18:03:49 INFO - PROCESS | 18286 | 18:03:51 INFO - PROCESS | 18286 | Cycle 1(1): loaded http://localhost:53488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53488/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:03:51 INFO - PROCESS | 18286 | RSS: Main: 165556224 18:03:51 INFO - PROCESS | 18286 | 18:03:53 INFO - PROCESS | 18286 | Cycle 1(1): loaded http://localhost:53488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:03:54 INFO - PROCESS | 18286 | RSS: Main: 166293504 18:03:54 INFO - PROCESS | 18286 | 18:03:57 INFO - PROCESS | 18286 | Cycle 1(1): loaded http://localhost:53488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:03:58 INFO - PROCESS | 18286 | RSS: Main: 165896192 18:03:58 INFO - PROCESS | 18286 | 18:04:01 INFO - PROCESS | 18286 | Cycle 1(1): loaded http://localhost:53488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:04:01 INFO - PROCESS | 18286 | RSS: Main: 165806080 18:04:01 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | Cycle 1(1): loaded http://localhost:53488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53488/tests/kraken/driver.html?testName=ai-astar) 18:04:03 INFO - PROCESS | 18286 | RSS: Main: 167362560 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | __start_tp_report 18:04:03 INFO - PROCESS | 18286 | _x_x_mozilla_page_load 18:04:03 INFO - PROCESS | 18286 | _x_x_mozilla_page_load_details 18:04:03 INFO - PROCESS | 18286 | |i|pagename|runs| 18:04:03 INFO - PROCESS | 18286 | |0;ai-astar;114;109;114;115;115;128;116;113;113;113 18:04:03 INFO - PROCESS | 18286 | |1;audio-beat-detection;158;135;167;190;135;161;166;134;189;130 18:04:03 INFO - PROCESS | 18286 | |2;audio-dft;165;162;165;166;165;163;163;163;171;161 18:04:03 INFO - PROCESS | 18286 | |3;audio-fft;73;73;73;157;75;78;73;73;158;74 18:04:03 INFO - PROCESS | 18286 | |4;audio-oscillator;94;93;141;95;93;96;145;94;93;139 18:04:03 INFO - PROCESS | 18286 | |5;imaging-gaussian-blur;118;120;118;118;117;119;119;119;118;117 18:04:03 INFO - PROCESS | 18286 | |6;imaging-darkroom;148;147;148;147;147;148;147;149;147;146 18:04:03 INFO - PROCESS | 18286 | |7;imaging-desaturate;95;97;96;96;96;96;96;97;96;95 18:04:03 INFO - PROCESS | 18286 | |8;json-parse-financial;64;66;65;69;66;65;64;83;64;63 18:04:03 INFO - PROCESS | 18286 | |9;json-stringify-tinderbox;63;64;64;64;64;63;64;64;63;64 18:04:03 INFO - PROCESS | 18286 | |10;stanford-crypto-aes;87;88;86;97;86;85;85;85;95;84 18:04:03 INFO - PROCESS | 18286 | |11;stanford-crypto-ccm;146;151;155;143;149;143;150;141;172;144 18:04:03 INFO - PROCESS | 18286 | |12;stanford-crypto-pbkdf2;175;175;173;176;175;172;174;172;172;178 18:04:03 INFO - PROCESS | 18286 | |13;stanford-crypto-sha256-iterative;74;74;79;71;73;74;73;73;73;72 18:04:03 INFO - PROCESS | 18286 | __end_tp_report 18:04:03 INFO - PROCESS | 18286 | __start_cc_report 18:04:03 INFO - PROCESS | 18286 | _x_x_mozilla_cycle_collect,923 18:04:03 INFO - PROCESS | 18286 | __end_cc_report 18:04:03 INFO - PROCESS | 18286 | __startTimestamp1460423043782__endTimestamp 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | ------- Summary: start ------- 18:04:03 INFO - PROCESS | 18286 | Number of tests: 14 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | [#0] ai-astar Cycles:10 Average:115.00 Median:114.50 stddev:4.94 (4.3%) stddev-sans-first:5.23 18:04:03 INFO - PROCESS | 18286 | Values: 114.0 109.0 114.0 115.0 115.0 128.0 116.0 113.0 113.0 113.0 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | [#1] audio-beat-detection Cycles:10 Average:156.50 Median:163.50 stddev:22.45 (13.7%) stddev-sans-first:23.80 18:04:03 INFO - PROCESS | 18286 | Values: 158.0 135.0 167.0 190.0 135.0 161.0 166.0 134.0 189.0 130.0 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:2.80 (1.7%) stddev-sans-first:2.96 18:04:03 INFO - PROCESS | 18286 | Values: 165.0 162.0 165.0 166.0 165.0 163.0 163.0 163.0 171.0 161.0 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | [#3] audio-fft Cycles:10 Average:90.70 Median:73.00 stddev:35.24 (48.3%) stddev-sans-first:36.79 18:04:03 INFO - PROCESS | 18286 | Values: 73.0 73.0 73.0 157.0 75.0 78.0 73.0 73.0 158.0 74.0 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:93.50 stddev:23.09 (24.7%) stddev-sans-first:23.90 18:04:03 INFO - PROCESS | 18286 | Values: 94.0 93.0 141.0 95.0 93.0 96.0 145.0 94.0 93.0 139.0 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.50 stddev:0.95 (0.8%) stddev-sans-first:1.00 18:04:03 INFO - PROCESS | 18286 | Values: 118.0 120.0 118.0 118.0 117.0 119.0 119.0 119.0 118.0 117.0 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 18:04:03 INFO - PROCESS | 18286 | Values: 148.0 147.0 148.0 147.0 147.0 148.0 147.0 149.0 147.0 146.0 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 18:04:03 INFO - PROCESS | 18286 | Values: 95.0 97.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 95.0 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:65.50 stddev:5.90 (9.0%) stddev-sans-first:6.16 18:04:03 INFO - PROCESS | 18286 | Values: 64.0 66.0 65.0 69.0 66.0 65.0 64.0 83.0 64.0 63.0 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 18:04:03 INFO - PROCESS | 18286 | Values: 63.0 64.0 64.0 64.0 64.0 63.0 64.0 64.0 63.0 64.0 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:86.50 stddev:4.49 (5.2%) stddev-sans-first:4.76 18:04:03 INFO - PROCESS | 18286 | Values: 87.0 88.0 86.0 97.0 86.0 85.0 85.0 85.0 95.0 84.0 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:149.50 stddev:9.06 (6.1%) stddev-sans-first:9.52 18:04:03 INFO - PROCESS | 18286 | Values: 146.0 151.0 155.0 143.0 149.0 143.0 150.0 141.0 172.0 144.0 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:175.00 stddev:1.99 (1.1%) stddev-sans-first:2.09 18:04:03 INFO - PROCESS | 18286 | Values: 175.0 175.0 173.0 176.0 175.0 172.0 174.0 172.0 172.0 178.0 18:04:03 INFO - PROCESS | 18286 | 18:04:03 INFO - PROCESS | 18286 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:73.50 stddev:2.12 (2.9%) stddev-sans-first:2.24 18:04:03 INFO - PROCESS | 18286 | Values: 74.0 74.0 79.0 71.0 73.0 74.0 73.0 73.0 73.0 72.0 18:04:03 INFO - PROCESS | 18286 | -------- Summary: end -------- 18:04:03 INFO - PROCESS | 18286 | 18:04:04 INFO - TEST-INFO | 18286: exit 0 18:04:04 INFO - TEST-OK | kraken | took 63223ms 18:04:04 INFO - SUITE-END | took 1178s 18:04:04 INFO - Completed test suite (00:19:38) 18:04:04 INFO - javascript benchmark 18:04:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2620.096066856934, 2657.0, 2658.920232393029, 2670.5860591608293, 2686.7313268673124, 4564.817407303708, 4576.1762882681105, 4605.240135377663, 4636.953630463694, 4660.533946605337, 4550.886227844306, 4627.676062675614, 4667.0665866826685, 4670.0, 4749.548792864673, 4341.9782901085455, 4378.452693413324, 4383.539728328527, 4449.5995360417555, 4482.417285752847, 4420.734755914639, 4486.259767138418, 4501.167284052461, 4525.570070843265, 4537.455505339364, 4215.861717336333, 4302.956970430287, 4345.869623911288, 4435.35687325336, 4451.532589078149, 4345.97827010863, 4348.043430445328, 4350.216960947028, 4356.912861742748, 4382.320740285261, 4319.114581510783, 4329.740215587043, 4335.1329734053315, 4344.131173765228, 4389.846355377578, 4476.462824461086, 4480.372747815309, 4608.516105808909, 4706.364640773486, 4715.0, 4988.8752781180765, 4998.40019197695, 5015.949840501585, 5016.247562865563, 5066.493350664941, 5053.444121146671, 5056.721880296583, 5066.493350664941, 5070.594352451795, 5072.010957863218, 4609.078184363141, 4630.629549636021, 4715.339852420664, 4741.715497070118, 4758.833440829554, 5191.143461328914, 5194.792208311701, 5195.0, 5219.5041471060185, 5270.0, 4803.159447096744, 4996.825111121166, 5002.824901128443, 5009.0, 5009.273655319958, 4924.556789888928, 5077.441481437039, 5080.923786143211, 5091.694498330112, 5123.795048198105, 4869.9269510957365, 4871.634627402959, 4877.609791216765, 4881.585065269421, 4901.411830580353, 4999.175136102503, 5008.549230569266, 5032.0, 5092.159793634083, 5095.286659867622, 4334.371516130143, 4338.544452832407, 4338.934915976263, 4350.086481838786, 4398.912021759611, 3695.796731179757, 3714.981425092857, 3739.102615372291, 3756.098536351256, 3784.905377365588, 4360.106178233455, 4383.3424986251675, 4402.823887044547, 4435.334699795057, 4443.777811109431, 4948.529889660476, 5066.240063990431, 5072.746362681851, 5077.162268225775, 5081.720505372166, 4362.650987920959, 4399.472063352418, 4400.22995975703, 4412.911741765147, 4434.0, 4585.839495617704, 4612.123696497655, 4632.814687412533, 4651.139539185194, 4681.461631912305, 4731.905361892812, 4733.266343716729, 4780.1873681473535, 4798.616110711135, 4821.325014497973, 5076.18780995039, 5085.745712714275, 5086.262491938722, 5103.8468845934685, 5160.819371321985, 4766.737829419415, 4794.256890182028, 4805.159097158054, 4807.230843065093, 4839.080574690797, 4881.975590122169, 4964.875878102932, 4985.775640096277, 5013.2981382607195, 5049.116404629249, 4972.204447288416, 5027.874303142451, 5029.698218106925, 5057.5195356442555, 5084.567811735896, 4847.781849816696, 4849.442314133919, 4865.245886887538, 4866.853994380174, 4917.188663870565, 4753.619710423227, 4811.855644330676, 4865.6107511398295, 4895.485973972682, 4910.116179087799, 4719.3628860103445, 4768.403949506312, 4785.090832741768, 4831.589314908272, 4835.129676658235, 4878.487758785276, 4881.51184881509, 4913.312136300992, 4931.654784165074, 4976.029674213493, 4729.43246810385, 4784.736839473862, 4852.296417019583, 4855.951440485691, 4881.51184881509], "value": 4634.6662011884255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.553633217993, 576.2767726503239, 591.3849596419724, 604.5103466192384, 614.1678026274401, 35443.0, 36941.44587831181, 36992.44511332326, 37042.44436333451, 37114.62885371145, 37997.43003854938, 38451.42322865159, 38622.0, 38675.41986870199, 38680.80659596705, 7713.922860771377, 7869.291763741262, 7871.094824095217, 7900.170482099383, 7935.325497332734, 7714.151443341228, 7808.570528620923, 7821.21787821219, 7867.685292588319, 7869.331106855924, 7653.693852245903, 7710.845783084335, 7714.575698336589, 7716.382689384835, 7721.073471183466, 7635.885461718079, 7641.1976742442075, 7673.577953212571, 7681.270279323483, 7687.577183254919, 7985.480943738638, 8085.3127484163915, 8090.312323452514, 8090.797730056737, 8116.6347514362, 30922.0, 37171.442428363596, 37614.0, 37939.62060379388, 38113.42829857554, 2845.0, 2867.5125228711167, 2878.928026799326, 2882.654081510232, 3311.536384906115, 24668.259952201464, 24873.378165545826, 24877.751222487906, 24975.5004899901, 25367.238982830546, 3027.197792584967, 3209.9197520062185, 3278.2623909620384, 3315.900522984314, 3332.0836769888233, 152977.0, 153653.0, 154160.22919885442, 154612.2269388646, 155028.0, 32764.0, 33040.83479582635, 33044.66955330464, 33101.33797324088, 33189.83405082959, 33705.83147084298, 33795.493067604, 48167.869088509135, 49786.50213497891, 49988.500114999115, 13839.861601384058, 14013.789793153112, 14042.578722638336, 14045.367958441895, 14123.646908827155, 10213.33613315132, 10264.384136951807, 10315.12321452685, 10329.586816527404, 10332.741681457874, 19048.238070477026, 19075.90462047681, 19208.327708530134, 19243.0, 19269.710954335696, 6827.453803695693, 6871.5189936703955, 7001.964990175016, 7062.505624606229, 7228.963855180796, 795.562440657636, 861.1603686405705, 878.6090189865448, 934.9205317548085, 999.8900120986685, 24590.877045614656, 25450.0, 25786.226413207634, 25936.0, 26134.73865261361, 979.9657012004689, 992.1071036067597, 996.4490903287607, 1005.9798804023878, 1012.2661070723666, 14078.084924480081, 14475.638109047148, 14601.269936503133, 14637.414503419745, 14785.704285914222, 342836.0, 349621.0, 350125.0, 350926.0, 351285.0, 39618.603813962065, 40146.19707605831, 40172.0, 40258.39612405816, 40309.984500774844, 1192.272713644676, 1205.0901569315286, 1206.5535751772077, 1233.648410203088, 1244.2410129820803, 25132.62301065522, 26218.475630487665, 26435.867820660773, 26496.470070598094, 26577.867110664323, 40348.79825600853, 41175.58824411718, 41234.79382603068, 41354.0, 41461.79269103635, 305269.0, 306597.0, 307344.0, 308277.0, 308842.0, 25613.615795762707, 38789.6121038786, 39579.2084158321, 39902.20195596014, 40252.79873600613, 39233.60766392414, 40601.593984060964, 40686.0, 40910.38634420546, 41221.38167927424, 35301.47047794234, 35530.28939421249, 35940.0, 36043.81978090198, 36131.63868361283, 33969.830150849084, 34296.314073717884, 34379.0, 34887.127821803646, 34887.476687849194, 30730.38539229158, 35530.46704299489, 35754.64245357513, 36861.0, 38060.42909356306, 31348.843255783577, 32167.839160804047, 32220.677793221766, 32370.0, 32406.83796581002, 24792.504149917262, 25468.0, 25504.617430738926, 25711.614325784754, 25811.0], "value": 16629.322261467383, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.394947412558, 366.4649611567112, 367.1518791591424, 369.7836765492187, 377.83941824724485, 15513.0, 15763.211839408026, 16617.335306587753, 16638.916805415985, 16687.66624667506, 15124.848751512482, 16512.25694843732, 16579.25393357299, 16641.0, 16666.66666666666, 4393.450818647669, 4637.0725854829, 4690.4605970313505, 4700.459447163568, 4703.553162449562, 4541.364209010741, 4580.862574122765, 4632.745199014053, 4643.55886190813, 4790.329353890458, 4760.071786001731, 4761.47623761386, 4775.737334446604, 4797.9520204797855, 4799.592034677056, 4648.930266046012, 4776.928346074795, 4789.928151077719, 4802.543758342969, 4849.563539281482, 4747.643926705511, 4749.121412538691, 4753.857384278443, 4754.786034628415, 4755.476897541268, 12290.324032178227, 12564.623061308175, 15738.291776870068, 20580.176792928265, 20614.690779638317, 1786.901720405377, 1972.615340008699, 2194.6817711431754, 2274.283600665785, 2328.580855446019, 8414.663413463453, 9174.311926605464, 9409.200217981479, 9625.90374096257, 9630.229581633452, 1764.6647137043922, 1778.5820332221917, 1830.6155707301482, 1841.3647291684347, 1857.3406440713488, 53186.73406632942, 64044.41235778844, 70182.29817701809, 70420.29579704188, 72059.0, 9823.508824558887, 9944.1547468466, 10096.14182794456, 10220.897791022144, 10343.844842327371, 14245.43018279278, 14309.427622894967, 14355.425782968774, 14366.712665746836, 14402.567922962327, 7240.312170343809, 7253.202147763742, 7315.817104572428, 7340.486165968331, 7476.663550140257, 6614.404703576702, 6713.227978782503, 6791.490638202055, 6832.111825462658, 7041.859162816715, 4347.999960009152, 4355.499117601453, 4384.12317536494, 4384.430024096847, 4404.8458303959205, 1748.8688348373923, 1788.65121301345, 1795.9640807183782, 1809.683305421546, 1848.1498510685235, 974.8196583632051, 993.3841018568534, 993.7018894331671, 1008.742770593494, 1014.077189757332, 16112.838871611368, 16181.110038947736, 16541.6691666166, 16625.168741562873, 16884.831151688573, 860.2000139869981, 873.8601823708176, 904.2494729374604, 940.6096469965024, 941.580996456584, 9013.414128081653, 9202.90797092034, 9295.72112836616, 9545.856812147824, 9559.713208603753, 372996.0, 381065.0, 384391.0, 388976.0, 389146.0, 75850.24149758542, 79054.20945790583, 79739.60130199311, 79945.60027199826, 80365.0, 811.3914564076942, 918.0452329577298, 958.6596758150896, 976.2824324121765, 979.5445118020154, 13013.47946082184, 13387.598372048855, 14888.478903238334, 15135.924320378768, 15147.469838555598, 32016.0, 32430.513542296412, 32705.836470817492, 32780.50829237611, 33314.16714582155, 40822.38766418447, 46212.53787462082, 46394.0, 46543.767281164735, 47180.292295614905, 7584.734534291273, 7794.571298578632, 7820.139784623573, 7858.371330293677, 8175.7138500152205, 8743.562821858754, 10920.672379828618, 11560.248583842023, 11620.356538193677, 11635.825462617899, 10084.092431681183, 10105.459026372168, 10119.494025298853, 10289.74275643115, 10569.577216911237, 9533.61865525399, 9879.407235565888, 9992.250581206294, 10129.493525323556, 10431.739206519898, 9707.805843883225, 9855.408675479493, 10479.318844275098, 10697.518611662339, 10790.298630588986, 7996.04047514302, 8024.759257222293, 8039.075506316848, 8143.470674406145, 8176.182381761776, 9817.705468835946, 10005.099541041342, 10046.844612869614, 10304.175665946856, 10624.468776561296], "value": 7984.546129595269, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.4718230663498, 1421.3177674716137, 1546.7679848022794, 1703.8977661340314, 1723.2159367487786, 6610.438112760421, 7153.213146553875, 7414.406847452205, 7448.180700122982, 7468.066491688545, 7254.854902901952, 7317.0, 7344.228855970113, 7380.926190738091, 7407.814804629874, 2218.6561083032157, 2247.4830788918557, 2262.332611879491, 2264.762199969004, 2266.0256089881345, 2241.4508445430893, 2249.853759505635, 2258.774122587736, 2282.3609389371004, 2282.99548198792, 2222.1333679864783, 2251.6960210371553, 2255.560165767676, 2259.9887000565054, 2273.5680220758086, 2218.7004754358277, 2223.110755697726, 2236.586231547169, 2253.312739614417, 2256.311824893407, 2159.2010955946243, 2166.42589713726, 2167.5448155887284, 2169.4467910682674, 2173.967390489144, 7656.0812702475505, 7658.310752032344, 7690.384769218449, 7736.342410895025, 7740.225977402271, 4483.439570053743, 4613.261878099522, 4618.515055919113, 4646.326282689025, 4672.836450724242, 2934.1344303430537, 3075.9846200769075, 3076.8769249230004, 3095.9845200773852, 3117.283024904262, 1822.1526989949737, 1847.2703282203454, 1849.824266694662, 1869.8597605179666, 1877.6995680691161, 10405.947970260177, 10572.629957951434, 10575.682729518127, 10601.78796424075, 10602.734931626694, 4054.2296963576828, 4105.3020986432375, 4262.957370426318, 4270.145970805851, 4307.978460107679, 8358.45670031446, 8376.623051962677, 8395.664173432995, 8433.536155511383, 8462.407631465861, 4578.198815207392, 4638.628909687217, 4638.698484598491, 4641.071785642817, 4661.813527458864, 3726.9068273293383, 4132.194222126656, 4229.090745489734, 4278.72188307759, 4324.805383757738, 3428.3143371325336, 3457.4122399192197, 3551.485034669958, 3567.4292113261754, 3605.260921511084, 1020.3112898793285, 1023.2274632652449, 1028.1774580335702, 1029.8249297619423, 1070.9410982396043, 1185.4191446191305, 1208.9274643521417, 1213.836132122152, 1231.1012960538858, 1237.4431505822415, 7192.244814294529, 7227.710891564384, 7314.96342518284, 7354.742584009641, 7447.3669738071785, 448.26260800982203, 456.8880624247081, 468.43319583304583, 468.43553518010714, 469.6900045969712, 5761.366249712528, 5792.218050563204, 5821.650700957956, 5851.093080572518, 5883.411658834168, 8619.569021548898, 9558.617655293849, 9611.0, 9613.327067105236, 9670.129688328085, 9342.48616326095, 9433.433993960385, 9585.137337639646, 9613.182879455184, 9634.855477167708, 7182.42540596751, 7272.272772722791, 7341.119065712149, 7351.926480735231, 7382.077240345065, 6900.0, 7081.114860642419, 7115.181754098138, 7130.465215108784, 7166.964165179141, 8656.0478347383, 8733.65065397377, 8894.332925030778, 8905.599248033983, 8963.686270980485, 8607.397482176188, 8856.114388561093, 9016.549172541478, 9178.954105229432, 9248.306377021885, 5763.0, 6101.633901965896, 6364.490840732823, 6374.74501019954, 6383.329750376143, 7119.181294151239, 7171.175314838861, 7191.460640452092, 7191.964040179975, 7199.1361036675935, 6251.180358829157, 6321.5258855586935, 6362.77730279438, 6458.967705161632, 6467.741290348522, 6488.643124628191, 6631.204255489372, 6639.4688424924925, 6646.401823835878, 6672.599644021374, 7047.577145371294, 7054.0, 7060.188078371053, 7098.538594991309, 7115.217326094229, 6391.169148010729, 6403.551751377545, 6444.065610486359, 6453.967730161319, 6468.288488266381, 6239.875202495834, 6240.438360547572, 6241.750329986749, 6268.529860260407, 6286.497080233479], "value": 4369.197845540503, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.591907248924, 296.57145424861073, 296.6632871690632, 306.9401466713992, 312.79355625287315, 5186.1442861927735, 5258.973705131474, 5271.630985830989, 5274.683518988863, 5283.0, 5178.352705911761, 5219.895602087956, 5220.373555173375, 5220.686758794475, 5231.163013917764, 3812.3519001769764, 3894.279558281713, 4051.6150965658217, 4058.3912413138046, 4065.857694980676, 4027.3354896442197, 4051.0427388006774, 4077.7349472284354, 4079.2861249281405, 4089.5501494835694, 3988.282109220339, 3997.5602683704915, 4015.8996025099314, 4022.235775202702, 4032.9395059074136, 3845.692344612424, 4037.051292946155, 4045.8988525286954, 4046.615571520701, 4046.8381264749373, 3562.3765840977985, 3568.83940222688, 3579.266250418658, 3594.946075808865, 3606.4229723244157, 4967.428745694219, 4969.180085285923, 4973.204287314049, 4974.079795237856, 5014.24786282057, 4564.977175114136, 4627.3521706961055, 4687.7656117194, 4687.929681054787, 4700.976495117537, 5470.9452905470835, 5471.753771080311, 5514.889702205974, 5538.529225015878, 5539.670479085031, 3928.4303775952326, 3932.6067393260732, 3933.7836418996944, 3945.506811648544, 3953.5651078381356, 5606.747696353674, 5724.853180057478, 5794.0, 5809.758876020529, 5829.387914268983, 4036.495438070241, 4039.8990025249605, 4044.170944956336, 4052.2300762855552, 4061.918761624751, 4101.85643502476, 4103.630673239423, 4106.1582375612925, 4108.856190033394, 4118.114605359862, 4669.252919532926, 4681.81272749093, 4690.9765451172525, 4697.647676424282, 4698.154332220233, 5249.868753281198, 5500.779968801203, 5552.833414997556, 5559.63862348946, 5578.86052848682, 1414.130309859429, 1429.7061159650532, 1433.8924580656285, 1435.3038776193537, 1445.3134760988446, 900.9234215091659, 952.5665822050951, 962.0860182826203, 989.8762654668167, 991.7768502086973, 4734.905301893943, 4866.221404575251, 4867.829625963145, 4901.50984901507, 4902.166631672553, 5702.942970570324, 5714.371419143891, 5719.370869204384, 5745.511631511368, 5801.274840644919, 4797.928031079537, 4877.95122048775, 4889.926651100236, 4898.363212782387, 4917.729524876167, 3045.482268014443, 3062.2038270049948, 3065.8196594311353, 3085.783995120365, 3101.3332133591384, 5414.214938833847, 5422.8915421691345, 5423.322084739408, 5430.294061771944, 5442.482964118402, 5681.318241810926, 5885.793997210077, 5901.557383196277, 5907.261592300963, 5914.260717410324, 5359.919601205985, 5381.13901775714, 5387.919181212285, 5391.191321301758, 5411.83764487066, 5514.834554963358, 5692.4876761090045, 5721.399253078367, 5749.13762935563, 5764.0, 5539.723013849372, 5543.584231182758, 5561.136014952222, 5601.467860553241, 5606.495415412633, 5385.9192112119135, 5392.973035134799, 5396.379416367011, 5400.540954018952, 5414.242006119225, 3986.0034991252187, 4039.272930872471, 4058.159288498004, 4058.7158898876796, 4083.122128742216, 5613.158026296088, 5663.150527420919, 5694.316681998187, 5725.427457254241, 5746.367899531132, 5492.697901615449, 5514.751836167462, 5520.475554822286, 5538.335399752055, 5566.972165139148, 5217.269582258411, 5546.972265138648, 5559.499645031967, 5600.187972744011, 5615.3823079462045, 5421.701806400686, 5440.292761940922, 5470.468268884719, 5473.675796121179, 5499.917501237404, 5305.893882122413, 5381.165919282517, 5578.246936663499, 5586.636868603528, 5595.804146854841, 5393.784248630011, 5422.15956526739, 5429.728513574227, 5436.429174936575, 5437.184422336523], "value": 4152.848202442794, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.7891435283528, 699.4044674831331, 712.6686090967701, 740.0, 744.6031185847569, 12297.200681955666, 12665.303408312539, 12716.491340346374, 12761.553345632881, 12765.808512872314, 11139.275947063436, 11277.097832173427, 11278.15413843961, 11287.322760634348, 11311.943440282808, 649.3538928765885, 779.9766007019798, 794.6622685358714, 806.4717609965483, 811.7645882694042, 640.69887153038, 645.8094862015694, 647.0359164844372, 648.1056142523312, 648.264220110176, 852.4885068958637, 853.5518852602403, 855.7347222361088, 856.0882659967147, 857.9914200857974, 845.1337379186322, 848.7920459487403, 849.9235068843802, 851.7231899632613, 852.0414533649645, 620.1318154583574, 623.8627501949563, 625.1123404765244, 625.8685676008043, 626.5081910700125, 12050.819237711441, 12089.335086570236, 12105.09211809118, 12116.636500904988, 12145.939270303592, 12573.182743121668, 12630.873691263061, 12702.174358666656, 12931.030172736988, 12977.091603587753, 9567.282453815922, 9781.364211326241, 9807.215422766161, 9987.900120998842, 9996.250281228864, 3288.786228895114, 3322.983385083059, 3335.299587086715, 3372.291818718072, 3395.456726923705, 46906.530934690556, 47044.29433558499, 47186.8203294917, 48054.279185812244, 48435.757821211024, 10267.281290309757, 10271.332363396505, 10285.74285642865, 10398.58405663765, 10615.84076238857, 17945.371911983017, 17965.281388744566, 17981.550461238574, 18011.639767204582, 18583.628327433376, 6573.80278591643, 6713.0, 6772.492063095287, 6985.301469852974, 7097.964510177416, 3539.345221134098, 3578.141246100917, 3630.3465376232, 3663.120850995742, 3705.314516814344, 2836.290927268183, 2930.1502564256125, 2933.1054028521507, 2943.249471384826, 2944.1903476543694, 501.15305134322875, 503.94456609772897, 507.91619382801423, 509.8725318670332, 512.8948565544055, 536.8094326514031, 557.3785229469194, 609.2354095609982, 621.0621960839165, 621.6083867163658, 7683.346915512132, 7689.692412303445, 7697.4226932980255, 7910.406719496061, 7929.852451686645, 453.5688708522383, 550.8099705601561, 591.9496842768327, 609.6585911889356, 614.4838335797951, 3593.3531964246686, 3903.9609603903596, 3904.511936007999, 3946.3883098119836, 3969.6824254059607, 49208.753956229986, 49496.75251623719, 49526.75236623794, 49585.75207124013, 50568.49431505711, 43370.78314608407, 43511.12977740491, 43658.12683746371, 43777.56222437799, 45235.32147017797, 39995.0, 40601.0, 40921.590784092376, 41063.58936410657, 42320.0, 7277.2722727726805, 7347.55914645123, 7499.5875226863045, 7700.114486834086, 7764.805879853049, 26405.471890562465, 26570.202893913214, 27026.054088106823, 27131.72868271292, 27356.179314620593, 32481.35037299288, 33618.15100169514, 34643.30713385668, 34995.0, 35441.29117417586, 10792.136629069813, 10844.67465976022, 10935.125189984623, 11126.777464450828, 11162.107031437628, 11914.225575337576, 11962.521499139937, 12122.151449398458, 12164.0, 12302.384880756106, 9434.245260379015, 9482.810343793224, 9902.950485247527, 9931.602735890483, 10627.628033018807, 10773.299735517166, 11646.24299420535, 11768.0, 11789.587364442203, 12049.33728644933, 9596.040395960348, 10392.636257730943, 10954.890451095705, 10970.23208375438, 11355.886441135483, 9119.544022798966, 9478.57346419399, 9557.761055973657, 9705.0, 9800.607975680892, 9315.6273749052, 9355.578998944928, 9559.522023898917, 9878.555465004236, 9973.950130249303], "value": 5822.244314601008, "unit": "score"}], "name": "dromaeo_css", "value": 6341.186798507503, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 114.0, 115.0, 115.0, 128.0, 116.0, 113.0, 113.0, 113.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 135.0, 167.0, 190.0, 135.0, 161.0, 166.0, 134.0, 189.0, 130.0], "value": 156.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 165.0, 166.0, 165.0, 163.0, 163.0, 163.0, 171.0, 161.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 157.0, 75.0, 78.0, 73.0, 73.0, 158.0, 74.0], "value": 90.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 141.0, 95.0, 93.0, 96.0, 145.0, 94.0, 93.0, 139.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 118.0, 118.0, 117.0, 119.0, 119.0, 119.0, 118.0, 117.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 149.0, 147.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 69.0, 66.0, 65.0, 64.0, 83.0, 64.0, 63.0], "value": 66.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 86.0, 97.0, 86.0, 85.0, 85.0, 85.0, 95.0, 84.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 151.0, 155.0, 143.0, 149.0, 143.0, 150.0, 141.0, 172.0, 144.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 173.0, 176.0, 175.0, 172.0, 174.0, 172.0, 172.0, 178.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 79.0, 71.0, 73.0, 74.0, 73.0, 73.0, 73.0, 72.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1612.2, "alertThreshold": 2.0}]} 18:04:05 INFO - Return code: 0 18:04:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:04:05 ERROR - # TBPL SUCCESS # 18:04:05 INFO - Running post-action listener: _resource_record_post_action 18:04:05 INFO - Running post-run listener: _resource_record_post_run 18:04:06 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404033536; Read time: 12; Write time: 242812 18:04:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 116449280; Read time: 0; Write time: 69708 18:04:06 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285712384; Read time: 12; Write time: 170904 18:04:06 INFO - Running post-run listener: _upload_blobber_files 18:04:06 INFO - Blob upload gear active. 18:04:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:04:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:04:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:04:06 INFO - (blobuploader) - INFO - Open directory for files ... 18:04:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:04:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:04:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:08 INFO - (blobuploader) - INFO - Done attempting. 18:04:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:04:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:04:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:08 INFO - (blobuploader) - INFO - Done attempting. 18:04:08 INFO - (blobuploader) - INFO - Iteration through files over. 18:04:08 INFO - Return code: 0 18:04:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:04:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:04:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/054a1bcc9f124720cd3e6f2f3ef6c41f94dc71f113424ee1f119a2bb8376b45abd2578d4e326fa26d186508240fd4763d55d2a84dacda5479f18247e9895babf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/179ae4b589141c1b8df1c2ed08eae4e936ab321711f522ff9d8d24632a6e4f06da44686049bf1f54e13246f8104e3681f0becaae5a4f43dc72a28d48941da7f2"} 18:04:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:04:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:04:08 INFO - Contents: 18:04:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/054a1bcc9f124720cd3e6f2f3ef6c41f94dc71f113424ee1f119a2bb8376b45abd2578d4e326fa26d186508240fd4763d55d2a84dacda5479f18247e9895babf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/179ae4b589141c1b8df1c2ed08eae4e936ab321711f522ff9d8d24632a6e4f06da44686049bf1f54e13246f8104e3681f0becaae5a4f43dc72a28d48941da7f2"} 18:04:08 INFO - Running post-run listener: copy_logs_to_upload_dir 18:04:08 INFO - Copying logs to upload dir... 18:04:08 INFO - mkdir: /builds/slave/test/build/upload/logs 18:04:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.928005 ========= master_lag: 0.65 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-11 18:04:09.443458) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 18:04:09.451425) ========= 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=1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988 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/054a1bcc9f124720cd3e6f2f3ef6c41f94dc71f113424ee1f119a2bb8376b45abd2578d4e326fa26d186508240fd4763d55d2a84dacda5479f18247e9895babf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/179ae4b589141c1b8df1c2ed08eae4e936ab321711f522ff9d8d24632a6e4f06da44686049bf1f54e13246f8104e3681f0becaae5a4f43dc72a28d48941da7f2"} build_url:https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010819 build_url: 'https://queue.taskcluster.net/v1/task/AZ3p0sKQRvKR-agScTBY6g/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/054a1bcc9f124720cd3e6f2f3ef6c41f94dc71f113424ee1f119a2bb8376b45abd2578d4e326fa26d186508240fd4763d55d2a84dacda5479f18247e9895babf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/179ae4b589141c1b8df1c2ed08eae4e936ab321711f522ff9d8d24632a6e4f06da44686049bf1f54e13246f8104e3681f0becaae5a4f43dc72a28d48941da7f2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 18:04:09.480111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 18:04:09.480456) ========= 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=1f5564757af27664ca02d71f000001b0-1460421286.824916-1412144988 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004303 ========= master_lag: 0.28 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 18:04:09.765238) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 18:04:09.765549) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 18:04:09.765833) ========= ========= Total master_lag: 1.12 =========