builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1460624823.65 results: success (0) buildid: 20160414011851 builduid: 72aeaf718bce407b9811359971e35fbc revision: c61fcac04879527762383a702a7d39957085aca3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:03.651573) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:03.652011) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:03.652299) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006429 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:03.674572) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:03.674909) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:03.692977) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:03.693390) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:03.743436) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:03.743755) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:03.744130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:03.744483) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 02:07:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-04-14 02:07:04 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099829 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:03.856563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:03.856889) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022141 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:03.906698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:03.907058) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c61fcac04879527762383a702a7d39957085aca3 --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 c61fcac04879527762383a702a7d39957085aca3 --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=7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 02:07:04,255 truncating revision to first 12 chars 2016-04-14 02:07:04,255 Setting DEBUG logging. 2016-04-14 02:07:04,255 attempt 1/10 2016-04-14 02:07:04,255 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c61fcac04879?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 02:07:04,513 unpacking tar archive at: fx-team-c61fcac04879/testing/mozharness/ program finished with exit code 0 elapsedTime=0.530716 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:04.450283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:04.450621) ========= echo c61fcac04879527762383a702a7d39957085aca3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c61fcac04879527762383a702a7d39957085aca3'] 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=7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c61fcac04879527762383a702a7d39957085aca3 program finished with exit code 0 elapsedTime=0.003512 script_repo_revision: 'c61fcac04879527762383a702a7d39957085aca3' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:04.498387) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:04.498691) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 02:07:04.508729) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-14 02:07:04.508997) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:07:04 INFO - MultiFileLogger online at 20160414 02:07:04 in /builds/slave/test 02:07:04 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 02:07:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:07:04 INFO - {'append_to_log': False, 02:07:04 INFO - 'base_work_dir': '/builds/slave/test', 02:07:04 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:07:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:07:04 INFO - 'branch': 'Fx-Team-Non-PGO', 02:07:04 INFO - 'buildbot_json_path': 'buildprops.json', 02:07:04 INFO - 'config_files': ('talos/linux_config.py',), 02:07:04 INFO - 'default_actions': ('clobber', 02:07:04 INFO - 'read-buildbot-config', 02:07:04 INFO - 'download-and-extract', 02:07:04 INFO - 'populate-webroot', 02:07:04 INFO - 'create-virtualenv', 02:07:04 INFO - 'install', 02:07:04 INFO - 'run-tests'), 02:07:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:07:04 INFO - 'download_minidump_stackwalk': True, 02:07:04 INFO - 'download_symbols': 'ondemand', 02:07:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:07:04 INFO - 'tooltool.py': '/tools/tooltool.py', 02:07:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:07:04 INFO - '/tools/misc-python/virtualenv.py')}, 02:07:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:07:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:07:04 INFO - 'installer_path': 'installer.exe', 02:07:04 INFO - 'log_level': 'info', 02:07:04 INFO - 'log_name': 'talos', 02:07:04 INFO - 'log_to_console': True, 02:07:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:07:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:07:04 INFO - 'opt_config_files': (), 02:07:04 INFO - 'pip_index': False, 02:07:04 INFO - 'sps_profile': False, 02:07:04 INFO - 'sps_profile_interval': 0, 02:07:04 INFO - 'suite': 'dromaeojs-e10s', 02:07:04 INFO - 'system_bits': '32', 02:07:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:07:04 INFO - 'title': 'talos-linux64-ix-005', 02:07:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:07:04 INFO - 'use_talos_json': True, 02:07:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:07:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:07:04 INFO - 'work_dir': 'build'} 02:07:04 INFO - ##### 02:07:04 INFO - ##### Running clobber step. 02:07:04 INFO - ##### 02:07:04 INFO - Running pre-action listener: _resource_record_pre_action 02:07:04 INFO - Running main action method: clobber 02:07:04 INFO - rmtree: /builds/slave/test/build 02:07:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:07:05 INFO - Running post-action listener: _resource_record_post_action 02:07:05 INFO - ##### 02:07:05 INFO - ##### Running read-buildbot-config step. 02:07:05 INFO - ##### 02:07:05 INFO - Running pre-action listener: _resource_record_pre_action 02:07:05 INFO - Running main action method: read_buildbot_config 02:07:05 INFO - Using buildbot properties: 02:07:05 INFO - { 02:07:05 INFO - "project": "", 02:07:05 INFO - "product": "firefox", 02:07:05 INFO - "script_repo_revision": "production", 02:07:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:07:05 INFO - "repository": "", 02:07:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:07:05 INFO - "buildid": "20160414011851", 02:07:05 INFO - "pgo_build": "False", 02:07:05 INFO - "basedir": "/builds/slave/test", 02:07:05 INFO - "buildnumber": 1147, 02:07:05 INFO - "slavename": "talos-linux64-ix-005", 02:07:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:07:05 INFO - "platform": "ubuntu64_hw", 02:07:05 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:07:05 INFO - "branch": "fx-team", 02:07:05 INFO - "repo_path": "integration/fx-team", 02:07:05 INFO - "revision": "c61fcac04879527762383a702a7d39957085aca3", 02:07:05 INFO - "stage_platform": "linux64", 02:07:05 INFO - "builduid": "72aeaf718bce407b9811359971e35fbc", 02:07:05 INFO - "slavebuilddir": "test" 02:07:05 INFO - } 02:07:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:07:05 INFO - Running post-action listener: _resource_record_post_action 02:07:05 INFO - ##### 02:07:05 INFO - ##### Running download-and-extract step. 02:07:05 INFO - ##### 02:07:05 INFO - Running pre-action listener: _resource_record_pre_action 02:07:05 INFO - Running main action method: download_and_extract 02:07:05 INFO - mkdir: /builds/slave/test/build/tests 02:07: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')]} 02:07:05 INFO - https://queue.taskcluster.net/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:07:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:07:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:07:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/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 02:07:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/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 02:07:06 INFO - Downloaded 1361 bytes. 02:07:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:07:06 INFO - Using the following test package requirements: 02:07:06 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:07:06 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:07:06 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:07:06 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:06 INFO - u'jsshell-linux-x86_64.zip'], 02:07:06 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:07:06 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:07:06 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:07:06 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:07:06 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:07:06 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:06 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:07:06 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:06 INFO - https://queue.taskcluster.net/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:07:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:07:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:07:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/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 02:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/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 02:07:07 INFO - Downloaded 22203341 bytes. 02:07:07 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'] 02:07:07 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 02:07:09 INFO - Return code: 0 02:07:09 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 02:07:09 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')]} 02:07:09 INFO - https://queue.taskcluster.net/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:07:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:07:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:07:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/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 02:07:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/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 02:07:13 INFO - Downloaded 22203341 bytes. 02:07:13 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'] 02:07:13 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 02:07:14 INFO - Return code: 0 02:07:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:14 INFO - https://queue.taskcluster.net/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:07:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:07:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:07:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/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 02:07:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/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 02:07:16 INFO - Downloaded 10841076 bytes. 02:07:16 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'] 02:07:16 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 02:07:16 INFO - Return code: 0 02:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:16 INFO - https://queue.taskcluster.net/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:07:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:07:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:07:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/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 02:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GGJkIWOkRkyb98NSEyzTpw/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 02:07:18 INFO - Downloaded 54164986 bytes. 02:07:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:07:18 INFO - mkdir: /builds/slave/test/properties 02:07:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:07:18 INFO - Writing to file /builds/slave/test/properties/build_url 02:07:18 INFO - Contents: 02:07:18 INFO - build_url:https://queue.taskcluster.net/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:07:18 INFO - Running post-action listener: _resource_record_post_action 02:07:18 INFO - Running post-action listener: set_extra_try_arguments 02:07:18 INFO - ##### 02:07:18 INFO - ##### Running populate-webroot step. 02:07:18 INFO - ##### 02:07:18 INFO - Running pre-action listener: _resource_record_pre_action 02:07:18 INFO - Running main action method: populate_webroot 02:07:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:07:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:07:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:07:18 INFO - '--tppagecycles', 02:07:18 INFO - '7'], 02:07:18 INFO - 'tests': ['tsvgm']}}, 02:07:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:07:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:07:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:07:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:07:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:07:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:07:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:18 INFO - 'talos_options': ['--disable-e10s'], 02:07:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:18 INFO - 'talos_options': ['--disable-e10s'], 02:07:18 INFO - 'tests': ['damp', 'tps']}, 02:07:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:18 INFO - 'tests': ['damp', 'tps']}, 02:07:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:07:18 INFO - 'tests': ['dromaeo_dom']}, 02:07:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:07:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:07:18 INFO - 'tests': ['a11yr', 02:07:18 INFO - 'ts_paint', 02:07:18 INFO - 'tpaint', 02:07:18 INFO - 'sessionrestore', 02:07:18 INFO - 'sessionrestore_no_auto_restore', 02:07:18 INFO - 'tabpaint']}, 02:07:18 INFO - 'other-e10s': {'tests': ['a11yr', 02:07:18 INFO - 'ts_paint', 02:07:18 INFO - 'tpaint', 02:07:18 INFO - 'sessionrestore', 02:07:18 INFO - 'sessionrestore_no_auto_restore', 02:07:18 INFO - 'tabpaint']}, 02:07:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:07:18 INFO - 'ts_paint', 02:07:18 INFO - 'tpaint', 02:07:18 INFO - 'sessionrestore', 02:07:18 INFO - 'sessionrestore_no_auto_restore', 02:07:18 INFO - 'tabpaint']}, 02:07:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:07:18 INFO - 'ts_paint', 02:07:18 INFO - 'tpaint', 02:07:18 INFO - 'sessionrestore', 02:07:18 INFO - 'sessionrestore_no_auto_restore', 02:07:18 INFO - 'tabpaint']}, 02:07:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:07:18 INFO - 'tests': ['a11yr', 02:07:18 INFO - 'ts_paint', 02:07:18 INFO - 'tpaint', 02:07:18 INFO - 'sessionrestore', 02:07:18 INFO - 'sessionrestore_no_auto_restore', 02:07:18 INFO - 'tabpaint']}, 02:07:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:07:18 INFO - 'tests': ['a11yr', 02:07:18 INFO - 'ts_paint', 02:07:18 INFO - 'tpaint', 02:07:18 INFO - 'sessionrestore', 02:07:18 INFO - 'sessionrestore_no_auto_restore', 02:07:18 INFO - 'tabpaint']}, 02:07:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:07:18 INFO - 'tests': ['tsvgx', 02:07:18 INFO - 'tsvgr_opacity', 02:07:18 INFO - 'tart', 02:07:18 INFO - 'tscrollx', 02:07:18 INFO - 'cart']}, 02:07:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:07:18 INFO - 'tsvgr_opacity', 02:07:18 INFO - 'tart', 02:07:18 INFO - 'tscrollx', 02:07:18 INFO - 'cart']}, 02:07:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:18 INFO - 'talos_options': ['--disable-e10s'], 02:07:18 INFO - 'tests': ['tp5o']}, 02:07:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:18 INFO - 'tests': ['tp5o']}, 02:07:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:18 INFO - 'talos_options': ['--disable-e10s', 02:07:18 INFO - '--xperf_path', 02:07:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:18 INFO - 'tests': ['tp5n']}, 02:07:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:18 INFO - 'talos_options': ['--xperf_path', 02:07:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:18 INFO - 'tests': ['tp5n']}}, 02:07:18 INFO - 'talos.zip': {'path': '', 02:07:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:07:18 INFO - Running post-action listener: _resource_record_post_action 02:07:18 INFO - ##### 02:07:18 INFO - ##### Running create-virtualenv step. 02:07:18 INFO - ##### 02:07:18 INFO - Running pre-action listener: _resource_record_pre_action 02:07:18 INFO - Running main action method: create_virtualenv 02:07:18 INFO - Creating virtualenv /builds/slave/test/build/venv 02:07:18 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 02:07:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:07:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:07:18 INFO - Using real prefix '/usr' 02:07:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:07:19 INFO - Installing distribute.............................................................................................................................................................................................done. 02:07:21 INFO - Installing pip.................done. 02:07:21 INFO - Return code: 0 02:07:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:21 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 0x7f0f507f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d88410>, '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 0x1d89310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d897a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', '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 02:07:21 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 02:07:21 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 02:07:21 INFO - Using env: {'DISPLAY': ':0', 02:07:21 INFO - 'HOME': '/home/cltbld', 02:07:21 INFO - 'LANG': 'en_US.UTF-8', 02:07:21 INFO - 'LANGUAGE': 'en_US:en', 02:07:21 INFO - 'LOGNAME': 'cltbld', 02:07:21 INFO - 'MAIL': '/var/mail/cltbld', 02:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:21 INFO - 'MOZ_NO_REMOTE': '1', 02:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:21 INFO - 'NO_EM_RESTART': '1', 02:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:21 INFO - 'PWD': '/builds/slave/test', 02:07:21 INFO - 'SHELL': '/bin/bash', 02:07:21 INFO - 'SHLVL': '1', 02:07:21 INFO - 'TERM': 'linux', 02:07:21 INFO - 'TMOUT': '86400', 02:07:21 INFO - 'USER': 'cltbld', 02:07:21 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', 02:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:21 INFO - '_': '/tools/buildbot/bin/python'} 02:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:21 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 02:07:21 INFO - Cleaning up... 02:07:21 INFO - Return code: 0 02:07:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:21 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 0x7f0f507f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d88410>, '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 0x1d89310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d897a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', '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 02:07:21 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 02:07:21 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 02:07:21 INFO - Using env: {'DISPLAY': ':0', 02:07:21 INFO - 'HOME': '/home/cltbld', 02:07:21 INFO - 'LANG': 'en_US.UTF-8', 02:07:21 INFO - 'LANGUAGE': 'en_US:en', 02:07:21 INFO - 'LOGNAME': 'cltbld', 02:07:21 INFO - 'MAIL': '/var/mail/cltbld', 02:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:21 INFO - 'MOZ_NO_REMOTE': '1', 02:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:21 INFO - 'NO_EM_RESTART': '1', 02:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:21 INFO - 'PWD': '/builds/slave/test', 02:07:21 INFO - 'SHELL': '/bin/bash', 02:07:21 INFO - 'SHLVL': '1', 02:07:21 INFO - 'TERM': 'linux', 02:07:21 INFO - 'TMOUT': '86400', 02:07:21 INFO - 'USER': 'cltbld', 02:07:21 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', 02:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:21 INFO - '_': '/tools/buildbot/bin/python'} 02:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:21 INFO - Downloading/unpacking psutil>=0.7.1 02:07:21 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 02:07:21 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 02:07:21 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 02:07:21 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 02:07:21 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 02:07:21 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 02:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:07:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:23 INFO - Installing collected packages: psutil 02:07:23 INFO - Running setup.py install for psutil 02:07:23 INFO - building 'psutil._psutil_linux' extension 02:07:23 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 02:07:24 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 02:07:24 INFO - building 'psutil._psutil_posix' extension 02:07:24 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 02:07:24 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 02:07:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:24 INFO - Successfully installed psutil 02:07:24 INFO - Cleaning up... 02:07:24 INFO - Return code: 0 02:07:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:24 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 0x7f0f507f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d88410>, '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 0x1d89310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d897a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', '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 02:07:24 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 02:07:24 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 02:07:24 INFO - Using env: {'DISPLAY': ':0', 02:07:24 INFO - 'HOME': '/home/cltbld', 02:07:24 INFO - 'LANG': 'en_US.UTF-8', 02:07:24 INFO - 'LANGUAGE': 'en_US:en', 02:07:24 INFO - 'LOGNAME': 'cltbld', 02:07:24 INFO - 'MAIL': '/var/mail/cltbld', 02:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:24 INFO - 'MOZ_NO_REMOTE': '1', 02:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:24 INFO - 'NO_EM_RESTART': '1', 02:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:24 INFO - 'PWD': '/builds/slave/test', 02:07:24 INFO - 'SHELL': '/bin/bash', 02:07:24 INFO - 'SHLVL': '1', 02:07:24 INFO - 'TERM': 'linux', 02:07:24 INFO - 'TMOUT': '86400', 02:07:24 INFO - 'USER': 'cltbld', 02:07:24 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', 02:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:24 INFO - '_': '/tools/buildbot/bin/python'} 02:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:07:24 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 02:07:24 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 02:07:24 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 02:07:24 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 02:07:24 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 02:07:24 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 02:07:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:07:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:07:26 INFO - Installing collected packages: mozsystemmonitor 02:07:26 INFO - Running setup.py install for mozsystemmonitor 02:07:26 INFO - Successfully installed mozsystemmonitor 02:07:26 INFO - Cleaning up... 02:07:26 INFO - Return code: 0 02:07:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:26 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 0x7f0f507f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d88410>, '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 0x1d89310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d897a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', '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 02:07:26 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 02:07:26 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 02:07:26 INFO - Using env: {'DISPLAY': ':0', 02:07:26 INFO - 'HOME': '/home/cltbld', 02:07:26 INFO - 'LANG': 'en_US.UTF-8', 02:07:26 INFO - 'LANGUAGE': 'en_US:en', 02:07:26 INFO - 'LOGNAME': 'cltbld', 02:07:26 INFO - 'MAIL': '/var/mail/cltbld', 02:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:26 INFO - 'MOZ_NO_REMOTE': '1', 02:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:26 INFO - 'NO_EM_RESTART': '1', 02:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:26 INFO - 'PWD': '/builds/slave/test', 02:07:26 INFO - 'SHELL': '/bin/bash', 02:07:26 INFO - 'SHLVL': '1', 02:07:26 INFO - 'TERM': 'linux', 02:07:26 INFO - 'TMOUT': '86400', 02:07:26 INFO - 'USER': 'cltbld', 02:07:26 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', 02:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:26 INFO - '_': '/tools/buildbot/bin/python'} 02:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:26 INFO - Downloading/unpacking blobuploader==1.2.4 02:07:26 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 02:07:26 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 02:07:26 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 02:07:26 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 02:07:26 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 02:07:26 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 02:07:28 INFO - Downloading blobuploader-1.2.4.tar.gz 02:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:07:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:07:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:07:29 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 02:07:29 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 02:07:29 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 02:07:29 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 02:07:29 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 02:07:29 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 02:07:29 INFO - Downloading docopt-0.6.1.tar.gz 02:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:07:29 INFO - Installing collected packages: blobuploader, requests, docopt 02:07:29 INFO - Running setup.py install for blobuploader 02:07:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:07:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:07:29 INFO - Running setup.py install for requests 02:07:29 INFO - Running setup.py install for docopt 02:07:30 INFO - Successfully installed blobuploader requests docopt 02:07:30 INFO - Cleaning up... 02:07:30 INFO - Return code: 0 02:07:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:30 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')]} 02:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:30 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')]} 02:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:30 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 0x7f0f507f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d88410>, '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 0x1d89310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d897a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', '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 02:07:30 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 02:07:30 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 02:07:30 INFO - Using env: {'DISPLAY': ':0', 02:07:30 INFO - 'HOME': '/home/cltbld', 02:07:30 INFO - 'LANG': 'en_US.UTF-8', 02:07:30 INFO - 'LANGUAGE': 'en_US:en', 02:07:30 INFO - 'LOGNAME': 'cltbld', 02:07:30 INFO - 'MAIL': '/var/mail/cltbld', 02:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:30 INFO - 'MOZ_NO_REMOTE': '1', 02:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:30 INFO - 'NO_EM_RESTART': '1', 02:07:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:30 INFO - 'PWD': '/builds/slave/test', 02:07:30 INFO - 'SHELL': '/bin/bash', 02:07:30 INFO - 'SHLVL': '1', 02:07:30 INFO - 'TERM': 'linux', 02:07:30 INFO - 'TMOUT': '86400', 02:07:30 INFO - 'USER': 'cltbld', 02:07:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', 02:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:30 INFO - '_': '/tools/buildbot/bin/python'} 02:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:30 INFO - Running setup.py (path:/tmp/pip-MmX2dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:30 INFO - Running setup.py (path:/tmp/pip-1hWGxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:30 INFO - Running setup.py (path:/tmp/pip-e0vwJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:30 INFO - Running setup.py (path:/tmp/pip-iuTEp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:30 INFO - Running setup.py (path:/tmp/pip-yxOuZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:30 INFO - Running setup.py (path:/tmp/pip-nkUChk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:30 INFO - Running setup.py (path:/tmp/pip-8kgQ2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:30 INFO - Running setup.py (path:/tmp/pip-CEswlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:30 INFO - Running setup.py (path:/tmp/pip-9ZSBBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:30 INFO - Running setup.py (path:/tmp/pip-tJeVlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:31 INFO - Running setup.py (path:/tmp/pip-hIMr0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:31 INFO - Running setup.py (path:/tmp/pip-batuvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:31 INFO - Running setup.py (path:/tmp/pip-BGbU02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:31 INFO - Running setup.py (path:/tmp/pip-7DCmMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:31 INFO - Running setup.py (path:/tmp/pip-h5LO4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:31 INFO - Running setup.py (path:/tmp/pip-a_90ME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:31 INFO - Running setup.py (path:/tmp/pip-Aek8vt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:07:31 INFO - Running setup.py install for manifestparser 02:07:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:07:31 INFO - Running setup.py install for mozcrash 02:07:31 INFO - Running setup.py install for mozdebug 02:07:31 INFO - Running setup.py install for mozdevice 02:07:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:07:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:07:31 INFO - Running setup.py install for mozfile 02:07:32 INFO - Running setup.py install for mozhttpd 02:07:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:07:32 INFO - Running setup.py install for mozinfo 02:07:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:07:32 INFO - Running setup.py install for mozInstall 02:07:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:07:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:07:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:07:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:07:32 INFO - Running setup.py install for mozleak 02:07:32 INFO - Running setup.py install for mozlog 02:07:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:07:32 INFO - Running setup.py install for moznetwork 02:07:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:07:32 INFO - Running setup.py install for mozprocess 02:07:32 INFO - Running setup.py install for mozprofile 02:07:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:07:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:07:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:07:32 INFO - Running setup.py install for mozrunner 02:07:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:07:33 INFO - Running setup.py install for mozscreenshot 02:07:33 INFO - Running setup.py install for moztest 02:07:33 INFO - Running setup.py install for mozversion 02:07:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:07:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:07:33 INFO - Cleaning up... 02:07:33 INFO - Return code: 0 02:07:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:33 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 0x7f0f507f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d88410>, '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 0x1d89310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d897a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', '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 02:07:33 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 02:07:33 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 02:07:33 INFO - Using env: {'DISPLAY': ':0', 02:07:33 INFO - 'HOME': '/home/cltbld', 02:07:33 INFO - 'LANG': 'en_US.UTF-8', 02:07:33 INFO - 'LANGUAGE': 'en_US:en', 02:07:33 INFO - 'LOGNAME': 'cltbld', 02:07:33 INFO - 'MAIL': '/var/mail/cltbld', 02:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:33 INFO - 'MOZ_NO_REMOTE': '1', 02:07:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:33 INFO - 'NO_EM_RESTART': '1', 02:07:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:33 INFO - 'PWD': '/builds/slave/test', 02:07:33 INFO - 'SHELL': '/bin/bash', 02:07:33 INFO - 'SHLVL': '1', 02:07:33 INFO - 'TERM': 'linux', 02:07:33 INFO - 'TMOUT': '86400', 02:07:33 INFO - 'USER': 'cltbld', 02:07:33 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', 02:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:33 INFO - '_': '/tools/buildbot/bin/python'} 02:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:33 INFO - Running setup.py (path:/tmp/pip-fBgG70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:33 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)) 02:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:33 INFO - Running setup.py (path:/tmp/pip-wPvTIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:33 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)) 02:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:33 INFO - Running setup.py (path:/tmp/pip-p6upJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:33 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)) 02:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:33 INFO - Running setup.py (path:/tmp/pip-Esq1YJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:33 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)) 02:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:33 INFO - Running setup.py (path:/tmp/pip-4UC76I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:33 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)) 02:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:33 INFO - Running setup.py (path:/tmp/pip-eN_gdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:34 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)) 02:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:34 INFO - Running setup.py (path:/tmp/pip-lZ5a5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:34 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)) 02:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:34 INFO - Running setup.py (path:/tmp/pip-Hh_87E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:34 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)) 02:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:34 INFO - Running setup.py (path:/tmp/pip-d6fVjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:34 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)) 02:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:34 INFO - Running setup.py (path:/tmp/pip-sMLcyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:34 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)) 02:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:34 INFO - Running setup.py (path:/tmp/pip-QO3OEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:34 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)) 02:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:34 INFO - Running setup.py (path:/tmp/pip-7DQo4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:34 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)) 02:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:34 INFO - Running setup.py (path:/tmp/pip-hUHG1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:34 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)) 02:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:34 INFO - Running setup.py (path:/tmp/pip-CBz_vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:34 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)) 02:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:34 INFO - Running setup.py (path:/tmp/pip-SI2CvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:34 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)) 02:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:34 INFO - Running setup.py (path:/tmp/pip-vIrSbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:34 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)) 02:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:34 INFO - Running setup.py (path:/tmp/pip-esuZ7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:34 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)) 02:07:34 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)) 02:07:34 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)) 02:07:34 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)) 02:07:34 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)) 02:07:34 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)) 02:07:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:07:34 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 02:07:34 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 02:07:34 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 02:07:34 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 02:07:34 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 02:07:34 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 02:07:36 INFO - Downloading blessings-1.6.tar.gz 02:07:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:07:36 INFO - Installing collected packages: blessings 02:07:36 INFO - Running setup.py install for blessings 02:07:36 INFO - Successfully installed blessings 02:07:36 INFO - Cleaning up... 02:07:36 INFO - Return code: 0 02:07:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:07:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:37 INFO - Reading from file tmpfile_stdout 02:07:37 INFO - Current package versions: 02:07:37 INFO - argparse == 1.2.1 02:07:37 INFO - blessings == 1.6 02:07:37 INFO - blobuploader == 1.2.4 02:07:37 INFO - docopt == 0.6.1 02:07:37 INFO - manifestparser == 1.1 02:07:37 INFO - mozInstall == 1.12 02:07:37 INFO - mozcrash == 0.17 02:07:37 INFO - mozdebug == 0.1 02:07:37 INFO - mozdevice == 0.48 02:07:37 INFO - mozfile == 1.2 02:07:37 INFO - mozhttpd == 0.7 02:07:37 INFO - mozinfo == 0.9 02:07:37 INFO - mozleak == 0.1 02:07:37 INFO - mozlog == 3.1 02:07:37 INFO - moznetwork == 0.27 02:07:37 INFO - mozprocess == 0.22 02:07:37 INFO - mozprofile == 0.28 02:07:37 INFO - mozrunner == 6.11 02:07:37 INFO - mozscreenshot == 0.1 02:07:37 INFO - mozsystemmonitor == 0.0 02:07:37 INFO - moztest == 0.7 02:07:37 INFO - mozversion == 1.4 02:07:37 INFO - psutil == 3.1.1 02:07:37 INFO - requests == 1.2.3 02:07:37 INFO - wsgiref == 0.1.2 02:07:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:37 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 0x7f0f507f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d88410>, '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 0x1d89310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d897a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', '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 02:07:37 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 02:07:37 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 02:07:37 INFO - Using env: {'DISPLAY': ':0', 02:07:37 INFO - 'HOME': '/home/cltbld', 02:07:37 INFO - 'LANG': 'en_US.UTF-8', 02:07:37 INFO - 'LANGUAGE': 'en_US:en', 02:07:37 INFO - 'LOGNAME': 'cltbld', 02:07:37 INFO - 'MAIL': '/var/mail/cltbld', 02:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:37 INFO - 'MOZ_NO_REMOTE': '1', 02:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:37 INFO - 'NO_EM_RESTART': '1', 02:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:37 INFO - 'PWD': '/builds/slave/test', 02:07:37 INFO - 'SHELL': '/bin/bash', 02:07:37 INFO - 'SHLVL': '1', 02:07:37 INFO - 'TERM': 'linux', 02:07:37 INFO - 'TMOUT': '86400', 02:07:37 INFO - 'USER': 'cltbld', 02:07:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', 02:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:37 INFO - '_': '/tools/buildbot/bin/python'} 02:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:37 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)) 02:07:37 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)) 02:07:37 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)) 02:07:37 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)) 02:07:37 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)) 02:07:37 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)) 02:07:37 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)) 02:07:37 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)) 02:07:37 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)) 02:07:37 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)) 02:07:37 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)) 02:07:37 INFO - Cleaning up... 02:07:37 INFO - Return code: 0 02:07:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f507f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d88410>, '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 0x1d89310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d897a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', '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 02:07:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:07:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:07:37 INFO - Using env: {'DISPLAY': ':0', 02:07:37 INFO - 'HOME': '/home/cltbld', 02:07:37 INFO - 'LANG': 'en_US.UTF-8', 02:07:37 INFO - 'LANGUAGE': 'en_US:en', 02:07:37 INFO - 'LOGNAME': 'cltbld', 02:07:37 INFO - 'MAIL': '/var/mail/cltbld', 02:07:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:37 INFO - 'MOZ_NO_REMOTE': '1', 02:07:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:37 INFO - 'NO_EM_RESTART': '1', 02:07:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:37 INFO - 'PWD': '/builds/slave/test', 02:07:37 INFO - 'SHELL': '/bin/bash', 02:07:37 INFO - 'SHLVL': '1', 02:07:37 INFO - 'TERM': 'linux', 02:07:37 INFO - 'TMOUT': '86400', 02:07:37 INFO - 'USER': 'cltbld', 02:07:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', 02:07:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:37 INFO - '_': '/tools/buildbot/bin/python'} 02:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:37 INFO - Downloading/unpacking jsonschema 02:07:37 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 02:07:37 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 02:07:37 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 02:07:37 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 02:07:37 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 02:07:37 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 02:07:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:07:39 INFO - Downloading/unpacking functools32 (from jsonschema) 02:07:39 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 02:07:39 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 02:07:39 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 02:07:39 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 02:07:39 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 02:07:39 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 02:07:39 INFO - Downloading functools32-3.2.3-2.tar.gz 02:07:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:07:39 INFO - warning: no files found matching '*.txt' 02:07:39 INFO - no previously-included directories found matching 'build' 02:07:39 INFO - no previously-included directories found matching 'dist' 02:07:39 INFO - no previously-included directories found matching '.git*' 02:07:39 INFO - Installing collected packages: jsonschema, functools32 02:07:39 INFO - Running setup.py install for functools32 02:07:39 INFO - warning: no files found matching '*.txt' 02:07:39 INFO - no previously-included directories found matching 'build' 02:07:39 INFO - no previously-included directories found matching 'dist' 02:07:39 INFO - no previously-included directories found matching '.git*' 02:07:39 INFO - Successfully installed jsonschema functools32 02:07:39 INFO - Cleaning up... 02:07:39 INFO - Return code: 0 02:07:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:07:39 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')]} 02:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:39 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')]} 02:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:39 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 0x7f0f507f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf95a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d88410>, '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 0x1d89310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d897a0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', '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 02:07:39 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 02:07:39 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 02:07:39 INFO - Using env: {'DISPLAY': ':0', 02:07:39 INFO - 'HOME': '/home/cltbld', 02:07:39 INFO - 'LANG': 'en_US.UTF-8', 02:07:39 INFO - 'LANGUAGE': 'en_US:en', 02:07:39 INFO - 'LOGNAME': 'cltbld', 02:07:39 INFO - 'MAIL': '/var/mail/cltbld', 02:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:39 INFO - 'MOZ_NO_REMOTE': '1', 02:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:39 INFO - 'NO_EM_RESTART': '1', 02:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:39 INFO - 'PWD': '/builds/slave/test', 02:07:39 INFO - 'SHELL': '/bin/bash', 02:07:39 INFO - 'SHLVL': '1', 02:07:39 INFO - 'TERM': 'linux', 02:07:39 INFO - 'TMOUT': '86400', 02:07:39 INFO - 'USER': 'cltbld', 02:07:39 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', 02:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:39 INFO - '_': '/tools/buildbot/bin/python'} 02:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:40 INFO - Downloading/unpacking flake8 02:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:07:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:07:42 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 02:07:42 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 02:07:42 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 02:07:42 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 02:07:42 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 02:07:42 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 02:07:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:07:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:07:42 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 02:07:42 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 02:07:42 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 02:07:42 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 02:07:42 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 02:07:42 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 02:07:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:07:42 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 02:07:42 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 02:07:42 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 02:07:42 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 02:07:42 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 02:07:42 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 02:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:07:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:07:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:07:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:07:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:07:42 INFO - no previously-included directories found matching 'docs/_build' 02:07:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:07:42 INFO - Running setup.py install for pep8 02:07:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:07:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:07:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:07:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:07:42 INFO - no previously-included directories found matching 'docs/_build' 02:07:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:07:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:07:42 INFO - Cleaning up... 02:07:42 INFO - Return code: 0 02:07:42 INFO - Running post-action listener: _resource_record_post_action 02:07:42 INFO - Running post-action listener: _start_resource_monitoring 02:07:42 INFO - Starting resource monitoring. 02:07:42 INFO - ##### 02:07:42 INFO - ##### Running install step. 02:07:42 INFO - ##### 02:07:42 INFO - Running pre-action listener: _resource_record_pre_action 02:07:42 INFO - Running main action method: install 02:07:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:43 INFO - Reading from file tmpfile_stdout 02:07:43 INFO - Detecting whether we're running mozinstall >=1.0... 02:07:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:07:43 INFO - Reading from file tmpfile_stdout 02:07:43 INFO - Output received: 02:07:43 INFO - Usage: mozinstall [options] installer 02:07:43 INFO - Options: 02:07:43 INFO - -h, --help show this help message and exit 02:07:43 INFO - -d DEST, --destination=DEST 02:07:43 INFO - Directory to install application into. [default: 02:07:43 INFO - "/builds/slave/test"] 02:07:43 INFO - --app=APP Application being installed. [default: firefox] 02:07:43 INFO - mkdir: /builds/slave/test/build/application 02:07:43 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'] 02:07:43 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 02:07:58 INFO - Reading from file tmpfile_stdout 02:07:58 INFO - Output received: 02:07:58 INFO - /builds/slave/test/build/application/firefox/firefox 02:07:58 INFO - Running post-action listener: _resource_record_post_action 02:07:58 INFO - ##### 02:07:58 INFO - ##### Running run-tests step. 02:07:58 INFO - ##### 02:07:58 INFO - Running pre-action listener: _resource_record_pre_action 02:07:58 INFO - Running main action method: run_tests 02:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:07:58 INFO - Python 2.7.3 02:07:58 INFO - Return code: 0 02:07:58 INFO - grabbing minidump binary from tooltool 02:07:58 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')]} 02:07:58 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 0x1d88410>, '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 0x1d89310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d897a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:07:58 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 02:07:58 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 02:07:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:07:58 INFO - Return code: 0 02:07:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:07:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:07:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:07:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:07:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:07:59 INFO - Return code: 0 02:07:59 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/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 02:07:59 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/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 02:07:59 INFO - Using env: {'DISPLAY': ':0', 02:07:59 INFO - 'HOME': '/home/cltbld', 02:07:59 INFO - 'LANG': 'en_US.UTF-8', 02:07:59 INFO - 'LANGUAGE': 'en_US:en', 02:07:59 INFO - 'LOGNAME': 'cltbld', 02:07:59 INFO - 'MAIL': '/var/mail/cltbld', 02:07:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:07:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:59 INFO - 'MOZ_NO_REMOTE': '1', 02:07:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:59 INFO - 'NO_EM_RESTART': '1', 02:07:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:59 INFO - 'PWD': '/builds/slave/test', 02:07:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:07:59 INFO - 'SHELL': '/bin/bash', 02:07:59 INFO - 'SHLVL': '1', 02:07:59 INFO - 'TERM': 'linux', 02:07:59 INFO - 'TMOUT': '86400', 02:07:59 INFO - 'USER': 'cltbld', 02:07:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239', 02:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:59 INFO - '_': '/tools/buildbot/bin/python'} 02:07:59 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/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 02:08:00 INFO - mozversion application_buildid: 20160414011851 02:08:00 INFO - mozversion application_changeset: c61fcac04879527762383a702a7d39957085aca3 02:08:00 INFO - mozversion application_display_name: Nightly 02:08:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:08:00 INFO - mozversion application_name: Firefox 02:08:00 INFO - mozversion application_remotingname: firefox 02:08:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:08:00 INFO - mozversion application_vendor: Mozilla 02:08:00 INFO - mozversion application_version: 48.0a1 02:08:00 INFO - mozversion platform_buildid: 20160414011851 02:08:00 INFO - mozversion platform_changeset: c61fcac04879527762383a702a7d39957085aca3 02:08:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:08:00 INFO - mozversion platform_version: 48.0a1 02:08:00 INFO - using testdate: 1460624880 02:08:00 INFO - actual date: 1460624880 02:08:00 INFO - starting webserver on 'localhost:53817' 02:08:00 INFO - SUITE-START | Running 2 tests 02:08:00 INFO - TEST-START | dromaeo_css 02:08:00 INFO - operating with platform_type : linux_ 02:08:00 INFO - Initialising browser for dromaeo_css test... 02:08:00 INFO - TEST-INFO | started process 21998 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI9akuE/profile http://localhost:53817/getInfo.html) 02:08:03 INFO - PROCESS | 21998 | 02:08:03 INFO - PROCESS | 21998 | (process:22066): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:08:04 INFO - PROCESS | 21998 | 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] 02:08:04 INFO - PROCESS | 21998 | __metrics Screen width/height:1600/1200 02:08:04 INFO - PROCESS | 21998 | colorDepth:24 02:08:04 INFO - PROCESS | 21998 | Browser inner width/height: 1024/697 02:08:04 INFO - PROCESS | 21998 | __metrics 02:08:05 ERROR - PROCESS | 21998 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:08:06 INFO - TEST-INFO | 21998: exit 0 02:08:06 INFO - Browser initialized. 02:08:06 INFO - Running cycle 1/1 for dromaeo_css test... 02:08:06 INFO - TEST-INFO | started process 22118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI9akuE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:08 INFO - PROCESS | 22118 | 02:08:08 INFO - PROCESS | 22118 | (process:22179): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:08:18 INFO - PROCESS | 22118 | RSS: Main: 164524032 02:08:18 INFO - PROCESS | 22118 | 02:09:08 INFO - PROCESS | 22118 | 1460624948001 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] 02:11:19 INFO - PROCESS | 22118 | Cycle 1(1): loaded http://localhost:53817/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53817/tests/dromaeo/cssquery-ext.html) 02:11:20 INFO - PROCESS | 22118 | RSS: Main: 169041920 02:11:20 INFO - PROCESS | 22118 | 02:14:22 INFO - PROCESS | 22118 | Cycle 1(1): loaded http://localhost:53817/tests/dromaeo/cssquery-ext.html (next: http://localhost:53817/tests/dromaeo/cssquery-jquery.html) 02:14:23 INFO - PROCESS | 22118 | RSS: Main: 165728256 02:14:23 INFO - PROCESS | 22118 | 02:17:24 INFO - PROCESS | 22118 | Cycle 1(1): loaded http://localhost:53817/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53817/tests/dromaeo/cssquery-mootools.html) 02:17:25 INFO - PROCESS | 22118 | RSS: Main: 166608896 02:17:25 INFO - PROCESS | 22118 | 02:20:27 INFO - PROCESS | 22118 | Cycle 1(1): loaded http://localhost:53817/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53817/tests/dromaeo/cssquery-prototype.html) 02:20:27 INFO - PROCESS | 22118 | RSS: Main: 164384768 02:20:27 INFO - PROCESS | 22118 | 02:23:30 INFO - PROCESS | 22118 | Cycle 1(1): loaded http://localhost:53817/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53817/tests/dromaeo/cssquery-yui.html) 02:23:31 INFO - PROCESS | 22118 | RSS: Main: 165842944 02:23:31 INFO - PROCESS | 22118 | 02:26:33 INFO - PROCESS | 22118 | Cycle 1(1): loaded http://localhost:53817/tests/dromaeo/cssquery-yui.html (next: http://localhost:53817/tests/dromaeo/cssquery-dojo.html) 02:26:33 INFO - PROCESS | 22118 | RSS: Main: 167682048 02:26:33 INFO - PROCESS | 22118 | 02:26:33 INFO - PROCESS | 22118 | __start_tp_report 02:26:33 INFO - PROCESS | 22118 | _x_x_mozilla_page_load 02:26:33 INFO - PROCESS | 22118 | _x_x_mozilla_page_load_details 02:26:33 INFO - PROCESS | 22118 | |i|pagename|runs| 02:26:33 INFO - PROCESS | 22118 | |0;dojo.html;2650.7084220735715;2705.553583658696;2724.1555117913435;2748.7388698073687;2755.421361514082;4635.652326075545;4652.116097941389;4659.813607455702;4704.482506924235;4709.529047095289;4703.85888423347;4723.716577005373;4732.05358928214;4800.663953523246;4822.493638167985;4309.655227581801;4340.978295108536;4385.035292235719;4399.406080179183;4417.82328706853;4321.438213032317;4375.540568240321;4392.846250381237;4403.801828917706;4409.360642706805;4317.503487098992;4365.257906155945;4365.825366985317;4413.404190434282;4461.174682683682;4383.123375324916;4392.516823149483;4418.7127836690515;4420.690551661352;4454.420925279725;4330.350447432878;4345.413369195181;4359.149965756678;4368.344748287751;4393.406890069831;4674.649401294916;4696.436427628672;4725.22033864412;4732.574068333866;4767.261074533453;5114.616403769732;5135.794568217267;5144.202648589475;5148.61385396093;5166.948330516684;5044.016416798726;5174.508421699932;5184.196449550288;5188;5209.739513024371;4732.716037037754;4747.905041899212;4795.064962332347;4796.472388037313;4811.133995880705;5241.580673546107;5247.055530004636;5251.081060814342;5278.9208161877605;5309.601779866448;4962.057209130254;4963.57809586182;4965.553100220925;5036.722980236123;5038.395392552844;5081.898362032739;5105.463926287761;5120.385553733576;5130.692158470503;5173.689578625294;4986.650934434628;5012.097822391932;5018.799248030111;5023.171176755867;5076.517730815566;4939.456659767423;5029.748512574357;5041.470645582234;5092.643514953992;5103.413107492612;4339.7396156230725;4357.106793107406;4364.410804541346;4377.1683380157665;4413.205622987893;3793.279276937373;3818.4654148419245;3825.387937929918;3846.826892789831;3865.4781604483037;4345.652347812167;4495.011097558532;4514;4545.5908968193025;4573.451185857718;5101.413337466165;5132.178851383761;5153.768080436389;5154.123798954187;5192.844214673491;4536.138133754576;4537.205988951986;4538.88652783683;4575.993281478136;4585.472670642852;4583.2666773316105;4599.563041511051;4644.651651126179;4651.837185698484;4664.277037059262;4912.656114072052;4913;4926.8768280793265;4931.235658472942;4984.102861484967;5140.43455219933;5152.072626927189;5176.145935920682;5178.171492561172;5218.086834803818;4897.632677549127;4920.40955085392;4961.70229786214;4992.80028798844;5005.499450055111;4997.600191984559;5023.196288593954;5029.119904016856;5034.119029169954;5083.034223497523;5003.249512573143;5096.031753966735;5103.693778373309;5113.079645663816;5115;4822.156122678447;4944.28307895346;4988.4263309719845;5027.145385284583;5073.467285934924;4914.778834952364;4916.483769204182;4939.53074457926;4952.182889823139;4965.4289756677;4755.762211889461;4819.975900120477;4846.757662116951;4859.611231101574;4905.092557876804;4990.3762029746285;5030.0694371541385;5033.370828646419;5089.185730283137;5108.131617625087;4819.373481447389;4857.587105096107;4867.683600565952;4868.075065737498;4868.196747536616 02:26:33 INFO - PROCESS | 22118 | |1;ext.html;564.1565859040733;600.8407771940435;605.963642181469;609.7652403824526;615.4553220399947;34213.486797698024;35226.29547409053;35282;35283.4707479388;35438.2912341753;37970;38778;38806;38864;38922.221555568874;7536.171021187665;7791.532508049507;7792.80517987052;7807.609619519029;7815.257550532719;7682.53904765713;7784.727534536292;7809.648565814524;7911.406644501657;7954.761357159266;7864.567448790314;7885.723999660013;7898.842023159534;7912.643931023118;7931.167227441093;7761.185075567068;7830.999999999972;7839.64721587527;7935.563544005077;7948.046234451845;7816.218378162138;7854.410919181028;7897.447178697494;7922.564258965755;7931.484453510503;37747;37925;38456;38592.80703596492;38602.613973860185;2513.54756143894;3105.3634005028916;3538;3636.381815091441;3722.758020728644;25623.994966091053;25719.357016074562;26161.73838261612;26442.206733798015;26486.337841553923;3188.4898416253286;3232.7413806895393;3270.9509357359657;3306.801591904469;3315.784474009206;151885;152651.23674381667;153547.23226383908;154601.22699386545;154755;53885.46114538883;54195.72902135543;54476.45523544714;54485.1827222592;54533;63991;65633;66248;66293.668531658;66342;13148.40832162555;13210;13245.337733113498;13251.734965300833;13291.601251962264;10916.290441121302;10965.671029869116;10993.450327483593;10996.945015274872;11001.834972475419;18836.81163188378;18984.240630374905;19044.571977044267;19045.142968566448;19132.23471061142;6797.6601169941305;6929.094499012711;7059.258777828254;7189.388901943394;7265.818354541178;880.8282384934876;885.2342723544087;959.8944116147218;1011.9241056920761;1019.7807471393686;27852.442951140863;28484.43031139407;28597;29084.854575726986;29178.41643167125;999.3853779925294;1029.3926583315729;1032.3547782635853;1047.8218702820539;1064.4677661169414;15257.38970441192;15270.160141192118;15502.5349239523;15634.3746250151;15648.530544083696;344389;349540;350364;350446;351278;49863.50136498589;50274;50604;50696;50830.491695083314;1203.8796120388067;1224.7305592769576;1234.4630085912656;1264.431006047264;1267.2143271171933;26794.866025669748;27887;28056.71943280541;28652.85673571619;28738.281542960758;43583.78208108939;43842.56157438385;44078.33882491829;44101.55898440975;44175;317610;317863;319099;320832;320850;25551.872240638677;25722.356941075876;25910.222693319232;25985.740142599087;26277.08030218933;43095.78452107719;43142;43170.56829431791;43797.34303985379;44104.338434924146;37240.6275937248;37532;37723.81138094292;37943;38409.231815364095;35893.82053089718;36535.08662283464;36579.26841463209;36646;37772.811135945245;32182.839085805357;36550.26899462049;36617;37263.44104838484;37411;28585.571216432185;29142.27144321409;29178.708212917598;29332.266693332836;29357.706422936353;22841.885790571607;22972.77027229773;23511.17710880111;23622.29133126009;24762.752372476043 02:26:33 INFO - PROCESS | 22118 | |2;jquery.html;380.5110433093474;384.8191350065469;386.52457477302914;401.4620408652405;402.80463974972133;13406.46374145033;15178.62053448663;16341.182940852968;16584.751228731562;16819;15560.610984725388;16025.358985640589;16322.020678759283;16411.343546258166;16450.506484805446;4804.231322988323;4894.119058569465;4961.206207006861;5012.323336349601;5049.091163590552;4971.577415919651;4994.650374473788;4999.900001999958;5002.674826136307;5010.624203184776;4811.711297322172;4974.403071631391;5034.723090230036;5041.873953151164;5062.797488100471;4984.850454486371;4999.675021123633;5000.97499512502;5051.26756620288;5055.31753213317;4395.120975804852;4503.504614492404;4514.6388288936805;4532.0709254602725;4567.063751930879;15268;18207.907525548377;19308.4207473776;19828.306009289605;19858.60282794336;1969.4485544047689;1979.7525309336334;2054.938351849447;2108.8523803333774;2424.9878750606313;13381.531646392426;13419.261940593264;13487.595372138852;13501.189928604315;13567.253801040939;1747.3796802135187;1804.1340156724846;1808.5569035586366;1827.43349561635;1849.2140840142886;66932.33067669309;68421.65789171022;68703;69593.65203174003;69736;9398.530073496298;9525.761650985327;9843.655472058443;9888.851667224853;10250.179985601135;12050.216735912138;13204.339783010812;13794.793078103836;13875.791863122062;13882.375293111834;7008.123984501937;7262.20115787263;7272.745453909193;7299.781006569811;7321.048263725682;6831.59010459374;6865.725370985105;6970.65146742671;6984.371406573433;7019.403350715246;6094.232672525007;6206.968965155145;6209.316975132731;6213.37866213375;6319.715612797435;1796.568823482355;1824.797480421851;1836.375632285003;1851.416803706855;1852.2683540001624;916.757059379265;920.4891285336569;942.3262367407336;946.8958414574391;974.7368210583245;16593.83406165947;16938.745918811226;17299.74050389245;17413.651726965643;17434.47696569105;906.2930913887178;936.0545848692869;937.7936853892132;941.6939494664261;990.65327135502;9308.162265396011;9369.765755856022;9693.806123877483;9828.606855725833;9925.1067403934;401570;402891;414261;414806;423582;70641.64679176675;76329;79878.6006069966;80569.59715201387;81102;970.403202030746;970.9611615535299;997.5211898288862;1010.8736407949007;1023.4524529376896;15265.160416177217;15284.541463756104;15377.384904604138;15447.691046179238;15696.607584810472;26246.475070498866;28360.432791343646;33175.83412082924;33566.160845979044;34356.14109647279;38998.2200355997;39954.200915982095;41205.38191927184;44361.11277774362;45257.32114018226;7401.814954625962;7526.5860377679755;7659;7864.5281283123195;7893.447458677838;11909;11921.403929803648;11965.820512692491;12032.939835300767;12173;10118.342307749972;10134.797304054026;10151.796964060824;10198.949005254926;10219.23355748307;9819.459929703935;10190.337628054152;10217.897821021694;10300.742481438025;10416.531256093342;8406.537640429591;9491.240700744062;10406.635767748092;10559.68320950342;10783.838242426213;7513.248675132661;7561.243875612615;7679.462437629312;7708;8069.959650201711;9109.635614575607;10442.843357349799;10465.319754215952;10558.947205263925;10787.946060269649 02:26:33 INFO - PROCESS | 22118 | |3;mootools.html;1440.3806363263795;1489.0916540910043;1616.773651688763;1776.0498133498581;1805.1425572852888;6773.559718618287;7725.92274077259;7860.724874629389;7992.16082311357;7993.680252789889;7932.6826926922995;7949.721759738411;8008.079070906848;8021.9197808022045;8022.1576734442915;2249.493863880626;2268.8638681679067;2273.5111950930545;2273.6589511573316;2276.1919518570917;2219.6004719150546;2222.9110835566557;2278;2287.553926984239;2288.96566551501;2242.4842286274165;2254.537819746948;2264.830137739668;2282.3837563857746;2285.7828506291876;2215.8448908576406;2217.5121473275854;2226.365485836537;2227.6992605998225;2232.55348930213;2219.6115679755976;2233.832462565314;2234.5642599693065;2241.3724157236;2243.23729931824;8113;8123.959380203061;8127.187281271885;8146.674133034671;8189.303909167668;4640.118377508263;4746.311784791186;4752.144613969484;4777.546133117348;4781.617470602343;2910.4906641337893;3049.8017628854277;3056.404001219763;3061.5254635531305;3069.5088785794164;1768.9557761055949;1787.4101546489628;1788.3830078622855;1793.4798908316573;1819.0086402910445;10234.283600147992;10395.532201050972;10399.844002340047;10417.531211095518;10436.843447348296;4155.563665815106;4181.937270940877;4313.956860431418;4324.2648749712625;4332.350147477903;8464.576771161417;8518.829623407497;8553.700620478377;8568.400211985227;8604.741857744277;4579.244424669959;4600.102979918951;4617.399738034102;4620.976895115503;4624.699394539344;3807.3146833569667;4221.873343799691;4239.04621460169;4316.6330861877095;4420.9115817684105;3509.94735078974;3555.7866528008403;3636.9818150909077;3650.4341827016856;3663.2307215484516;1067.9946600267103;1103.1119948441421;1106.601623415586;1107.0534692837668;1112.4993752811267;796.1600511460465;823.2755175445569;878.8154487557557;889.621910687955;916.5875356089787;5284.81503147388;5443.836684899459;5631;5669.744861481243;5696.487316141567;798.1419973528364;850.4089657687848;865.5023361567124;906.3655441191192;917.1928702741678;3647.434647629622;3734.533183352081;3819.3316169670197;3853.497136116917;3942.113024569449;9825.803483930282;10043.397396156253;10049.748756281006;10055.29612927088;10062.446565438824;9894;9966.352187107816;10009.799804003878;10014.949925250326;10110.646127385506;7144.464165187632;7391.15001774792;7503.5873026982945;7596;7615.961920190363;5529.419410961952;5568.359638641446;5642.971785141048;5658.943410565842;5727.656340619409;8950.68672596456;9035.186833185046;9134.451932884049;9209;9218.446893186161;8579.485230886166;8837.734867953972;8897.555122243992;8902.465852048897;8904.554772261232;6282.246130464374;6687.465002799861;6867.450603951772;6877.277885821916;7072.71709131629;7338.596377199306;7359.632018399166;7435.442341824277;7453.515521491086;7460.7015719372785;6553.049807777941;6762.323767623395;6810.046593476818;6826.965865170642;6878.518503704692;6688.762578922915;6760.08738820253;6809.250982392032;6840.965795170992;6900.171979362509;6187.566870319034;6239.688015599293;6261.906071408841;6281.371862813682;6290.559660823698;4752.073345697556;4785.377900872864;4793.5685788279225;4863.4650188479945;4943.0361079590575;4779.713217206979;4926.162552366035;4962.702237865596;4964.230544265644;4997.200447928314 02:26:33 INFO - PROCESS | 22118 | |4;prototype.html;315.5660966171514;318.2648082928434;325.3915178615987;326.36033374585816;330.96855798699147;5320.361556613207;5325.334333208349;5346.679199248048;5399.217113518537;5410.91883621745;5313.760880760366;5317.8404647860625;5329.653572517784;5334.119870221409;5340;3928;4033.4353190553197;4164.042270277838;4171.374293855915;4172.97913510432;4175.269327867626;4181.163767246548;4181.519125300599;4190.958090419087;4192.413062171298;4160.230357383879;4180.749155050691;4181.853635122771;4184.8744537663915;4188.81150348235;4101.343784994401;4147.543770185277;4148.56440073791;4155.524788700029;4181.895452613679;3633.727470439701;3649.5620525537106;3659.0486473517076;3659.5425571803526;3660.9267814643827;5075.406756885025;5087.313212716273;5088.567471764904;5093.923591146098;5098.592112631018;4393.934090988638;4666.929996050062;4777.737224452654;4790.658615587641;4794.208955522335;5525.668459892419;5542.418046105141;5551.195076713854;5557.027520183951;5570.610057295991;3880.805959702032;3915.7650540967347;3923.4507168996365;3929.98035009826;3932.980335098306;5615.792604589992;5878;5881.794137205177;5920.407959204088;5943.55423343251;3990.9424002639325;4011.157656892027;4015.3976903464713;4035.7174997750462;4041.5756345583877;4020.6783457323345;4027.8520621622697;4058.2201192183447;4059.5331536873637;4087.1825634873144;4561.931571026437;4643.326717625993;4653.302004699322;4666.580007799314;4666.883327916829;5575.470330318613;5590.077637189818;5590.133529302964;5620.409856965041;5635.887282254332;1375.2985977151725;1396.3786115178648;1398.880895283769;1399.860013998592;1403.6069900427692;875.746033650247;901.724973882972;946.1342871272708;961.6489981156967;966.3815158298695;4839.443464001614;4861.708297502161;4863.927041094315;4934.309196712463;4942.827001054946;5718.942810571841;5726.427357264323;5750.683712395775;5754.367019627837;5772.451617096369;4911.214205727067;4992.2511623256805;4998.650094493423;5004.574611158019;5049.267856160836;3069.677683843209;3100.5039193728894;3104.62744470665;3118.3139709263924;3136.7766571037314;5500.669959802424;5534.584906132056;5557.44425557441;5567.944320556823;5601.355844077902;5860.3260625027815;5946.970265148733;6002.129691194752;6004.489618382487;6017.044460550339;5437.537809286176;5565.193047008162;5576.749046292926;5577.721113944368;5602.327720673546;5647.519960803378;5799.795148517292;5829.825105246679;5830.76676932918;5830.909617902518;5673.631213971079;5688.971555142198;5697;5731.5701322400155;5740.253767010429;5548.916766248429;5549.944500555104;5567.582431317586;5572.108462645957;5609.298837645294;3926.1362500249897;3955.4857868476915;4024.8390064397095;4027.617376349242;4032.7580345179385;5732.3121225453215;5801.274840644919;5812.564057695605;5819.970900145472;5824.970875145597;5626.606137570331;5631.409551606307;5640.605157638925;5643.746031428514;5646;5457.744718714638;5583.664980101207;5600.635958662674;5633.126865335879;5634.661920284796;5259.079661059376;5538.307711536058;5556.083246264483;5561.749721262634;5563.912028824042;5459;5625.537360286273;5630.943690563042;5633.0987042073075;5649.152627105967;5483.588730845282;5516.613837031369;5529.723513824373;5540.36285827135;5541.418151094077 02:26:33 INFO - PROCESS | 22118 | |5;yui.html;644.2430144580118;772.1236396689762;779.1429427629608;792.04162962815;807.8222790985989;12116.878831211685;12222;12342.753144937096;12357.629271121858;12429.440675169617;12403.875961240408;12585.056120790954;12651;12710.618681439548;12763.23420594765;641.6503005861816;771.9729809456657;786.5005721366916;805.472415567804;811.2820154163549;804.7304153108715;811.2050190813006;811.6225954930956;811.7808191788243;811.9391045671568;839;842.9789255268606;844.0968164064453;849.218718778722;852.1606217875419;835.1356346181703;846.2595229174473;847.0851480401183;848.4103548034119;848.8259906719107;600.5255847880169;608.4888693497439;615.6552330694781;617;618.8916939535563;11760.411979400995;11865.288082714978;11903.761924761542;11966.282023078644;11995.580154694544;12980.870191298061;13106.475740970349;13148.934255328662;13376;13424.932875335659;9075.18323350895;9159.40463869853;9177.128172823572;9318;9357.344985850994;3274.6397896231397;3288.3094550144497;3293.7200337971303;3321.7674762766615;3348.0792781984906;46212.76893615544;46297.30554041692;47425;47891.281630775564;48060.51939480595;10237.846432303522;10245.334053286513;10347.120494757879;10374.948125259325;10548.525316360781;16710.164491775362;18392.08039598015;18547;18599.44201673952;18677.906610467133;6685.39831415175;6738.19141702989;6813.7955861324235;6821.624810635363;6932.168139823253;3708.0915175782106;3743.457198706227;3779.9244015119543;3792.943105853359;3807.428885667172;3036.149878034154;3262.1844538865284;3374;3399.184195792992;3399.9490007649906;601.4466690644617;604.3020311540179;605.0742364182807;608.5770389579288;615.5844804756771;515.5463192390672;549.9285092937972;551.6662419236385;619.575590720358;640.4460141977156;7503.812404689927;7757.72847950319;7758.14660387357;7813.218678132142;7876.803079923047;540.4460428061269;582.6533212738414;616.3928530397554;619.4703528483172;622.6730966242668;3523.2777280657406;3638.526991491089;3691.667749902522;3735.2716220336774;3828.712846536521;51543.7422812891;52205.477945220824;52212.73893630583;52555.73722131365;52596.055295852966;46261;46699.29951050737;47076.293855592194;47903.5209647906;47928;42947.78526107349;43599.56400435955;43632.3455148173;43829.56170438319;45170.09659806785;6421.389967953037;6676.632785196861;6716.597004179765;6953.6523173842115;6963.234044255027;28952.276193095342;29108.854455727585;29300.853495732386;29842.104736857927;30375.848120759256;39641.60358396495;39753.80123099366;40395.79802100971;41128.38307425451;41214.38178427266;11546.249493782878;11646.359450230319;11661.125415594033;11777.764444711229;12004.279743215435;10839.024487796136;11161.107111431229;11272.098232141572;11329.71675708114;11396.601118960796;11376.356936560038;11405.258658187191;11419.029382502247;11427.371494567878;11430.542778288775;11126.721831954266;11213.102951763676;11274.436278186222;11279.718007049561;11514.53941842317;9956.153726933291;10846.837297440703;10877.238593298709;10933.343999360064;11270.042046425817;9098.226650734761;9189.954050229973;9318.440893546138;9405.670801521914;9425;9535.713928582154;9691.224702023963;9714.659986900424;9730.464824434725;9874.654387096418 02:26:33 INFO - PROCESS | 22118 | __end_tp_report 02:26:33 INFO - PROCESS | 22118 | __start_cc_report 02:26:33 INFO - PROCESS | 22118 | _x_x_mozilla_cycle_collect,354 02:26:33 INFO - PROCESS | 22118 | __end_cc_report 02:26:33 INFO - PROCESS | 22118 | __startTimestamp1460625993773__endTimestamp 02:26:33 INFO - PROCESS | 22118 | 02:26:33 INFO - PROCESS | 22118 | ------- Summary: start ------- 02:26:33 INFO - PROCESS | 22118 | Number of tests: 6 02:26:33 INFO - PROCESS | 22118 | 02:26:33 INFO - PROCESS | 22118 | [#0] dojo.html Cycles:165 Average:4732.08 Median:4867.68 stddev:484.96 (10.0%) stddev-sans-first:458.14 02:26:33 INFO - PROCESS | 22118 | Values: 2650.7 2705.6 2724.2 2748.7 2755.4 4635.7 4652.1 4659.8 4704.5 4709.5 4703.9 4723.7 4732.1 4800.7 4822.5 4309.7 4341.0 4385.0 4399.4 4417.8 4321.4 4375.5 4392.8 4403.8 4409.4 4317.5 4365.3 4365.8 4413.4 4461.2 4383.1 4392.5 4418.7 4420.7 4454.4 4330.4 4345.4 4359.1 4368.3 4393.4 4674.6 4696.4 4725.2 4732.6 4767.3 5114.6 5135.8 5144.2 5148.6 5166.9 5044.0 5174.5 5184.2 5188.0 5209.7 4732.7 4747.9 4795.1 4796.5 4811.1 5241.6 5247.1 5251.1 5278.9 5309.6 4962.1 4963.6 4965.6 5036.7 5038.4 5081.9 5105.5 5120.4 5130.7 5173.7 4986.7 5012.1 5018.8 5023.2 5076.5 4939.5 5029.7 5041.5 5092.6 5103.4 4339.7 4357.1 4364.4 4377.2 4413.2 3793.3 3818.5 3825.4 3846.8 3865.5 4345.7 4495.0 4514.0 4545.6 4573.5 5101.4 5132.2 5153.8 5154.1 5192.8 4536.1 4537.2 4538.9 4576.0 4585.5 4583.3 4599.6 4644.7 4651.8 4664.3 4912.7 4913.0 4926.9 4931.2 4984.1 5140.4 5152.1 5176.1 5178.2 5218.1 4897.6 4920.4 4961.7 4992.8 5005.5 4997.6 5023.2 5029.1 5034.1 5083.0 5003.2 5096.0 5103.7 5113.1 5115.0 4822.2 4944.3 4988.4 5027.1 5073.5 4914.8 4916.5 4939.5 4952.2 4965.4 4755.8 4820.0 4846.8 4859.6 4905.1 4990.4 5030.1 5033.4 5089.2 5108.1 4819.4 4857.6 4867.7 4868.1 4868.2 02:26:33 INFO - PROCESS | 22118 | 02:26:33 INFO - PROCESS | 22118 | [#1] ext.html Cycles:180 Average:43859.80 Median:19765.10 stddev:75804.29 (383.5%) stddev-sans-first:75947.24 02:26:33 INFO - PROCESS | 22118 | Values: 564.2 600.8 606.0 609.8 615.5 34213.5 35226.3 35282.0 35283.5 35438.3 37970.0 38778.0 38806.0 38864.0 38922.2 7536.2 7791.5 7792.8 7807.6 7815.3 7682.5 7784.7 7809.6 7911.4 7954.8 7864.6 7885.7 7898.8 7912.6 7931.2 7761.2 7831.0 7839.6 7935.6 7948.0 7816.2 7854.4 7897.4 7922.6 7931.5 37747.0 37925.0 38456.0 38592.8 38602.6 2513.5 3105.4 3538.0 3636.4 3722.8 25624.0 25719.4 26161.7 26442.2 26486.3 3188.5 3232.7 3271.0 3306.8 3315.8 151885.0 152651.2 153547.2 154601.2 154755.0 53885.5 54195.7 54476.5 54485.2 54533.0 63991.0 65633.0 66248.0 66293.7 66342.0 13148.4 13210.0 13245.3 13251.7 13291.6 10916.3 10965.7 10993.5 10996.9 11001.8 18836.8 18984.2 19044.6 19045.1 19132.2 6797.7 6929.1 7059.3 7189.4 7265.8 880.8 885.2 959.9 1011.9 1019.8 27852.4 28484.4 28597.0 29084.9 29178.4 999.4 1029.4 1032.4 1047.8 1064.5 15257.4 15270.2 15502.5 15634.4 15648.5 344389.0 349540.0 350364.0 350446.0 351278.0 49863.5 50274.0 50604.0 50696.0 50830.5 1203.9 1224.7 1234.5 1264.4 1267.2 26794.9 27887.0 28056.7 28652.9 28738.3 43583.8 43842.6 44078.3 44101.6 44175.0 317610.0 317863.0 319099.0 320832.0 320850.0 25551.9 25722.4 25910.2 25985.7 26277.1 43095.8 43142.0 43170.6 43797.3 44104.3 37240.6 37532.0 37723.8 37943.0 38409.2 35893.8 36535.1 36579.3 36646.0 37772.8 32182.8 36550.3 36617.0 37263.4 37411.0 28585.6 29142.3 29178.7 29332.3 29357.7 22841.9 22972.8 23511.2 23622.3 24762.8 02:26:33 INFO - PROCESS | 22118 | 02:26:33 INFO - PROCESS | 22118 | [#2] jquery.html Cycles:180 Average:24493.71 Median:419194.00 stddev:67711.11 (16.2%) stddev-sans-first:67876.86 02:26:33 INFO - PROCESS | 22118 | Values: 380.5 384.8 386.5 401.5 402.8 13406.5 15178.6 16341.2 16584.8 16819.0 15560.6 16025.4 16322.0 16411.3 16450.5 4804.2 4894.1 4961.2 5012.3 5049.1 4971.6 4994.7 4999.9 5002.7 5010.6 4811.7 4974.4 5034.7 5041.9 5062.8 4984.9 4999.7 5001.0 5051.3 5055.3 4395.1 4503.5 4514.6 4532.1 4567.1 15268.0 18207.9 19308.4 19828.3 19858.6 1969.4 1979.8 2054.9 2108.9 2425.0 13381.5 13419.3 13487.6 13501.2 13567.3 1747.4 1804.1 1808.6 1827.4 1849.2 66932.3 68421.7 68703.0 69593.7 69736.0 9398.5 9525.8 9843.7 9888.9 10250.2 12050.2 13204.3 13794.8 13875.8 13882.4 7008.1 7262.2 7272.7 7299.8 7321.0 6831.6 6865.7 6970.7 6984.4 7019.4 6094.2 6207.0 6209.3 6213.4 6319.7 1796.6 1824.8 1836.4 1851.4 1852.3 916.8 920.5 942.3 946.9 974.7 16593.8 16938.7 17299.7 17413.7 17434.5 906.3 936.1 937.8 941.7 990.7 9308.2 9369.8 9693.8 9828.6 9925.1 401570.0 402891.0 414261.0 414806.0 423582.0 70641.6 76329.0 79878.6 80569.6 81102.0 970.4 971.0 997.5 1010.9 1023.5 15265.2 15284.5 15377.4 15447.7 15696.6 26246.5 28360.4 33175.8 33566.2 34356.1 38998.2 39954.2 41205.4 44361.1 45257.3 7401.8 7526.6 7659.0 7864.5 7893.4 11909.0 11921.4 11965.8 12032.9 12173.0 10118.3 10134.8 10151.8 10198.9 10219.2 9819.5 10190.3 10217.9 10300.7 10416.5 8406.5 9491.2 10406.6 10559.7 10783.8 7513.2 7561.2 7679.5 7708.0 8070.0 9109.6 10442.8 10465.3 10558.9 10787.9 02:26:33 INFO - PROCESS | 22118 | 02:26:33 INFO - PROCESS | 22118 | [#3] mootools.html Cycles:180 Average:5243.20 Median:4828.52 stddev:2838.62 (58.8%) stddev-sans-first:2832.20 02:26:33 INFO - PROCESS | 22118 | Values: 1440.4 1489.1 1616.8 1776.0 1805.1 6773.6 7725.9 7860.7 7992.2 7993.7 7932.7 7949.7 8008.1 8021.9 8022.2 2249.5 2268.9 2273.5 2273.7 2276.2 2219.6 2222.9 2278.0 2287.6 2289.0 2242.5 2254.5 2264.8 2282.4 2285.8 2215.8 2217.5 2226.4 2227.7 2232.6 2219.6 2233.8 2234.6 2241.4 2243.2 8113.0 8124.0 8127.2 8146.7 8189.3 4640.1 4746.3 4752.1 4777.5 4781.6 2910.5 3049.8 3056.4 3061.5 3069.5 1769.0 1787.4 1788.4 1793.5 1819.0 10234.3 10395.5 10399.8 10417.5 10436.8 4155.6 4181.9 4314.0 4324.3 4332.4 8464.6 8518.8 8553.7 8568.4 8604.7 4579.2 4600.1 4617.4 4621.0 4624.7 3807.3 4221.9 4239.0 4316.6 4420.9 3509.9 3555.8 3637.0 3650.4 3663.2 1068.0 1103.1 1106.6 1107.1 1112.5 796.2 823.3 878.8 889.6 916.6 5284.8 5443.8 5631.0 5669.7 5696.5 798.1 850.4 865.5 906.4 917.2 3647.4 3734.5 3819.3 3853.5 3942.1 9825.8 10043.4 10049.7 10055.3 10062.4 9894.0 9966.4 10009.8 10014.9 10110.6 7144.5 7391.2 7503.6 7596.0 7616.0 5529.4 5568.4 5643.0 5658.9 5727.7 8950.7 9035.2 9134.5 9209.0 9218.4 8579.5 8837.7 8897.6 8902.5 8904.6 6282.2 6687.5 6867.5 6877.3 7072.7 7338.6 7359.6 7435.4 7453.5 7460.7 6553.0 6762.3 6810.0 6827.0 6878.5 6688.8 6760.1 6809.3 6841.0 6900.2 6187.6 6239.7 6261.9 6281.4 6290.6 4752.1 4785.4 4793.6 4863.5 4943.0 4779.7 4926.2 4962.7 4964.2 4997.2 02:26:33 INFO - PROCESS | 22118 | 02:26:33 INFO - PROCESS | 22118 | [#4] prototype.html Cycles:180 Average:4652.34 Median:5331.89 stddev:1370.01 (25.7%) stddev-sans-first:1334.63 02:26:33 INFO - PROCESS | 22118 | Values: 315.6 318.3 325.4 326.4 331.0 5320.4 5325.3 5346.7 5399.2 5410.9 5313.8 5317.8 5329.7 5334.1 5340.0 3928.0 4033.4 4164.0 4171.4 4173.0 4175.3 4181.2 4181.5 4191.0 4192.4 4160.2 4180.7 4181.9 4184.9 4188.8 4101.3 4147.5 4148.6 4155.5 4181.9 3633.7 3649.6 3659.0 3659.5 3660.9 5075.4 5087.3 5088.6 5093.9 5098.6 4393.9 4666.9 4777.7 4790.7 4794.2 5525.7 5542.4 5551.2 5557.0 5570.6 3880.8 3915.8 3923.5 3930.0 3933.0 5615.8 5878.0 5881.8 5920.4 5943.6 3990.9 4011.2 4015.4 4035.7 4041.6 4020.7 4027.9 4058.2 4059.5 4087.2 4561.9 4643.3 4653.3 4666.6 4666.9 5575.5 5590.1 5590.1 5620.4 5635.9 1375.3 1396.4 1398.9 1399.9 1403.6 875.7 901.7 946.1 961.6 966.4 4839.4 4861.7 4863.9 4934.3 4942.8 5718.9 5726.4 5750.7 5754.4 5772.5 4911.2 4992.3 4998.7 5004.6 5049.3 3069.7 3100.5 3104.6 3118.3 3136.8 5500.7 5534.6 5557.4 5567.9 5601.4 5860.3 5947.0 6002.1 6004.5 6017.0 5437.5 5565.2 5576.7 5577.7 5602.3 5647.5 5799.8 5829.8 5830.8 5830.9 5673.6 5689.0 5697.0 5731.6 5740.3 5548.9 5549.9 5567.6 5572.1 5609.3 3926.1 3955.5 4024.8 4027.6 4032.8 5732.3 5801.3 5812.6 5820.0 5825.0 5626.6 5631.4 5640.6 5643.7 5646.0 5457.7 5583.7 5600.6 5633.1 5634.7 5259.1 5538.3 5556.1 5561.7 5563.9 5459.0 5625.5 5630.9 5633.1 5649.2 5483.6 5516.6 5529.7 5540.4 5541.4 02:26:33 INFO - PROCESS | 22118 | 02:26:33 INFO - PROCESS | 22118 | [#5] yui.html Cycles:180 Average:12924.22 Median:46279.15 stddev:14730.21 (31.8%) stddev-sans-first:14742.66 02:26:33 INFO - PROCESS | 22118 | Values: 644.2 772.1 779.1 792.0 807.8 12116.9 12222.0 12342.8 12357.6 12429.4 12403.9 12585.1 12651.0 12710.6 12763.2 641.7 772.0 786.5 805.5 811.3 804.7 811.2 811.6 811.8 811.9 839.0 843.0 844.1 849.2 852.2 835.1 846.3 847.1 848.4 848.8 600.5 608.5 615.7 617.0 618.9 11760.4 11865.3 11903.8 11966.3 11995.6 12980.9 13106.5 13148.9 13376.0 13424.9 9075.2 9159.4 9177.1 9318.0 9357.3 3274.6 3288.3 3293.7 3321.8 3348.1 46212.8 46297.3 47425.0 47891.3 48060.5 10237.8 10245.3 10347.1 10374.9 10548.5 16710.2 18392.1 18547.0 18599.4 18677.9 6685.4 6738.2 6813.8 6821.6 6932.2 3708.1 3743.5 3779.9 3792.9 3807.4 3036.1 3262.2 3374.0 3399.2 3399.9 601.4 604.3 605.1 608.6 615.6 515.5 549.9 551.7 619.6 640.4 7503.8 7757.7 7758.1 7813.2 7876.8 540.4 582.7 616.4 619.5 622.7 3523.3 3638.5 3691.7 3735.3 3828.7 51543.7 52205.5 52212.7 52555.7 52596.1 46261.0 46699.3 47076.3 47903.5 47928.0 42947.8 43599.6 43632.3 43829.6 45170.1 6421.4 6676.6 6716.6 6953.7 6963.2 28952.3 29108.9 29300.9 29842.1 30375.8 39641.6 39753.8 40395.8 41128.4 41214.4 11546.2 11646.4 11661.1 11777.8 12004.3 10839.0 11161.1 11272.1 11329.7 11396.6 11376.4 11405.3 11419.0 11427.4 11430.5 11126.7 11213.1 11274.4 11279.7 11514.5 9956.2 10846.8 10877.2 10933.3 11270.0 9098.2 9190.0 9318.4 9405.7 9425.0 9535.7 9691.2 9714.7 9730.5 9874.7 02:26:33 INFO - PROCESS | 22118 | -------- Summary: end -------- 02:26:33 INFO - PROCESS | 22118 | 02:26:34 INFO - TEST-INFO | 22118: exit 0 02:26:34 INFO - TEST-OK | dromaeo_css | took 1114363ms 02:26:34 INFO - TEST-START | kraken 02:26:34 INFO - operating with platform_type : linux_ 02:26:34 INFO - Initialising browser for kraken test... 02:26:34 INFO - TEST-INFO | started process 22353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc8AR6s/profile http://localhost:53817/getInfo.html) 02:26:38 INFO - PROCESS | 22353 | 02:26:38 INFO - PROCESS | 22353 | (process:22421): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:26:38 INFO - PROCESS | 22353 | 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] 02:26:38 INFO - PROCESS | 22353 | __metrics Screen width/height:1600/1200 02:26:38 INFO - PROCESS | 22353 | colorDepth:24 02:26:38 INFO - PROCESS | 22353 | Browser inner width/height: 1024/697 02:26:38 INFO - PROCESS | 22353 | __metrics 02:26:39 ERROR - PROCESS | 22353 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:26:40 INFO - TEST-INFO | 22353: exit 0 02:26:40 INFO - Browser initialized. 02:26:40 INFO - Running cycle 1/1 for kraken test... 02:26:40 INFO - TEST-INFO | started process 22472 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc8AR6s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:42 INFO - PROCESS | 22472 | 02:26:42 INFO - PROCESS | 22472 | (process:22532): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:26:52 INFO - PROCESS | 22472 | RSS: Main: 164671488 02:26:52 INFO - PROCESS | 22472 | 02:26:54 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:53817/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53817/tests/kraken/driver.html?testName=audio-beat-detection) 02:26:55 INFO - PROCESS | 22472 | RSS: Main: 168407040 02:26:55 INFO - PROCESS | 22472 | 02:26:58 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:53817/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53817/tests/kraken/driver.html?testName=audio-dft) 02:26:59 INFO - PROCESS | 22472 | RSS: Main: 172441600 02:26:59 INFO - PROCESS | 22472 | 02:27:02 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:53817/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53817/tests/kraken/driver.html?testName=audio-fft) 02:27:02 INFO - PROCESS | 22472 | RSS: Main: 163737600 02:27:02 INFO - PROCESS | 22472 | 02:27:05 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:53817/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53817/tests/kraken/driver.html?testName=audio-oscillator) 02:27:05 INFO - PROCESS | 22472 | RSS: Main: 164151296 02:27:05 INFO - PROCESS | 22472 | 02:27:08 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:53817/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53817/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:27:08 INFO - PROCESS | 22472 | RSS: Main: 164450304 02:27:08 INFO - PROCESS | 22472 | 02:27:11 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:53817/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53817/tests/kraken/driver.html?testName=imaging-darkroom) 02:27:12 INFO - PROCESS | 22472 | RSS: Main: 164700160 02:27:12 INFO - PROCESS | 22472 | 02:27:15 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:53817/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53817/tests/kraken/driver.html?testName=imaging-desaturate) 02:27:16 INFO - PROCESS | 22472 | RSS: Main: 164241408 02:27:16 INFO - PROCESS | 22472 | 02:27:19 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:53817/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53817/tests/kraken/driver.html?testName=json-parse-financial) 02:27:20 INFO - PROCESS | 22472 | RSS: Main: 164720640 02:27:20 INFO - PROCESS | 22472 | 02:27:21 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:53817/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53817/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:27:22 INFO - PROCESS | 22472 | RSS: Main: 165171200 02:27:22 INFO - PROCESS | 22472 | 02:27:24 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:53817/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53817/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:27:24 INFO - PROCESS | 22472 | RSS: Main: 165117952 02:27:24 INFO - PROCESS | 22472 | 02:27:27 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:53817/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53817/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:27:27 INFO - PROCESS | 22472 | RSS: Main: 165580800 02:27:27 INFO - PROCESS | 22472 | 02:27:30 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:53817/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53817/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:27:31 INFO - PROCESS | 22472 | RSS: Main: 166039552 02:27:31 INFO - PROCESS | 22472 | 02:27:34 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:53817/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53817/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:27:34 INFO - PROCESS | 22472 | RSS: Main: 166019072 02:27:34 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | Cycle 1(1): loaded http://localhost:53817/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53817/tests/kraken/driver.html?testName=ai-astar) 02:27:36 INFO - PROCESS | 22472 | RSS: Main: 167321600 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | __start_tp_report 02:27:36 INFO - PROCESS | 22472 | _x_x_mozilla_page_load 02:27:36 INFO - PROCESS | 22472 | _x_x_mozilla_page_load_details 02:27:36 INFO - PROCESS | 22472 | |i|pagename|runs| 02:27:36 INFO - PROCESS | 22472 | |0;ai-astar;114;109;116;116;115;126;115;113;114;114 02:27:36 INFO - PROCESS | 22472 | |1;audio-beat-detection;160;145;158;195;134;161;164;138;186;135 02:27:36 INFO - PROCESS | 22472 | |2;audio-dft;166;163;166;172;162;164;162;163;165;163 02:27:36 INFO - PROCESS | 22472 | |3;audio-fft;74;73;73;165;74;77;74;77;156;78 02:27:36 INFO - PROCESS | 22472 | |4;audio-oscillator;94;94;149;94;94;94;140;94;94;136 02:27:36 INFO - PROCESS | 22472 | |5;imaging-gaussian-blur;117;117;117;117;119;117;117;117;118;118 02:27:36 INFO - PROCESS | 22472 | |6;imaging-darkroom;147;147;148;147;148;147;147;147;147;146 02:27:36 INFO - PROCESS | 22472 | |7;imaging-desaturate;95;96;95;96;97;100;96;96;95;95 02:27:36 INFO - PROCESS | 22472 | |8;json-parse-financial;67;66;65;64;67;66;65;87;63;65 02:27:36 INFO - PROCESS | 22472 | |9;json-stringify-tinderbox;64;65;63;64;64;64;63;69;64;65 02:27:36 INFO - PROCESS | 22472 | |10;stanford-crypto-aes;94;83;84;87;87;86;85;88;87;85 02:27:36 INFO - PROCESS | 22472 | |11;stanford-crypto-ccm;141;141;139;144;143;137;136;139;166;150 02:27:36 INFO - PROCESS | 22472 | |12;stanford-crypto-pbkdf2;173;172;171;170;182;174;168;169;171;171 02:27:36 INFO - PROCESS | 22472 | |13;stanford-crypto-sha256-iterative;74;83;75;75;74;72;73;71;73;70 02:27:36 INFO - PROCESS | 22472 | __end_tp_report 02:27:36 INFO - PROCESS | 22472 | __start_cc_report 02:27:36 INFO - PROCESS | 22472 | _x_x_mozilla_cycle_collect,911 02:27:36 INFO - PROCESS | 22472 | __end_cc_report 02:27:36 INFO - PROCESS | 22472 | __startTimestamp1460626056907__endTimestamp 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | ------- Summary: start ------- 02:27:36 INFO - PROCESS | 22472 | Number of tests: 14 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:4.29 (3.7%) stddev-sans-first:4.53 02:27:36 INFO - PROCESS | 22472 | Values: 114.0 109.0 116.0 116.0 115.0 126.0 115.0 113.0 114.0 114.0 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | [#1] audio-beat-detection Cycles:10 Average:157.60 Median:160.50 stddev:20.75 (12.9%) stddev-sans-first:21.99 02:27:36 INFO - PROCESS | 22472 | Values: 160.0 145.0 158.0 195.0 134.0 161.0 164.0 138.0 186.0 135.0 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:2.99 (1.8%) stddev-sans-first:3.13 02:27:36 INFO - PROCESS | 22472 | Values: 166.0 163.0 166.0 172.0 162.0 164.0 162.0 163.0 165.0 163.0 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | [#3] audio-fft Cycles:10 Average:92.10 Median:74.00 stddev:36.16 (48.9%) stddev-sans-first:37.75 02:27:36 INFO - PROCESS | 22472 | Values: 74.0 73.0 73.0 165.0 74.0 77.0 74.0 77.0 156.0 78.0 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:94.00 stddev:23.24 (24.7%) stddev-sans-first:24.06 02:27:36 INFO - PROCESS | 22472 | Values: 94.0 94.0 149.0 94.0 94.0 94.0 140.0 94.0 94.0 136.0 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 02:27:36 INFO - PROCESS | 22472 | Values: 117.0 117.0 117.0 117.0 119.0 117.0 117.0 117.0 118.0 118.0 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 02:27:36 INFO - PROCESS | 22472 | Values: 147.0 147.0 148.0 147.0 148.0 147.0 147.0 147.0 147.0 146.0 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.52 (1.6%) stddev-sans-first:1.56 02:27:36 INFO - PROCESS | 22472 | Values: 95.0 96.0 95.0 96.0 97.0 100.0 96.0 96.0 95.0 95.0 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:66.00 stddev:6.96 (10.6%) stddev-sans-first:7.38 02:27:36 INFO - PROCESS | 22472 | Values: 67.0 66.0 65.0 64.0 67.0 66.0 65.0 87.0 63.0 65.0 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.00 stddev:1.72 (2.7%) stddev-sans-first:1.81 02:27:36 INFO - PROCESS | 22472 | Values: 64.0 65.0 63.0 64.0 64.0 64.0 63.0 69.0 64.0 65.0 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:3.03 (3.5%) stddev-sans-first:1.64 02:27:36 INFO - PROCESS | 22472 | Values: 94.0 83.0 84.0 87.0 87.0 86.0 85.0 88.0 87.0 85.0 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:142.00 stddev:8.82 (6.2%) stddev-sans-first:9.31 02:27:36 INFO - PROCESS | 22472 | Values: 141.0 141.0 139.0 144.0 143.0 137.0 136.0 139.0 166.0 150.0 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:171.50 stddev:3.90 (2.3%) stddev-sans-first:4.12 02:27:36 INFO - PROCESS | 22472 | Values: 173.0 172.0 171.0 170.0 182.0 174.0 168.0 169.0 171.0 171.0 02:27:36 INFO - PROCESS | 22472 | 02:27:36 INFO - PROCESS | 22472 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:74.00 stddev:3.56 (4.8%) stddev-sans-first:3.77 02:27:36 INFO - PROCESS | 22472 | Values: 74.0 83.0 75.0 75.0 74.0 72.0 73.0 71.0 73.0 70.0 02:27:36 INFO - PROCESS | 22472 | -------- Summary: end -------- 02:27:36 INFO - PROCESS | 22472 | 02:27:37 INFO - TEST-INFO | 22472: exit 0 02:27:37 INFO - TEST-OK | kraken | took 63440ms 02:27:37 INFO - SUITE-END | took 1177s 02:27:38 INFO - Completed test suite (00:19:37) 02:27:38 INFO - javascript benchmark 02:27:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2650.7084220735715, 2705.553583658696, 2724.1555117913435, 2748.7388698073687, 2755.421361514082, 4635.652326075545, 4652.116097941389, 4659.813607455702, 4704.482506924235, 4709.529047095289, 4703.85888423347, 4723.716577005373, 4732.05358928214, 4800.663953523246, 4822.493638167985, 4309.655227581801, 4340.978295108536, 4385.035292235719, 4399.406080179183, 4417.82328706853, 4321.438213032317, 4375.540568240321, 4392.846250381237, 4403.801828917706, 4409.360642706805, 4317.503487098992, 4365.257906155945, 4365.825366985317, 4413.404190434282, 4461.174682683682, 4383.123375324916, 4392.516823149483, 4418.7127836690515, 4420.690551661352, 4454.420925279725, 4330.350447432878, 4345.413369195181, 4359.149965756678, 4368.344748287751, 4393.406890069831, 4674.649401294916, 4696.436427628672, 4725.22033864412, 4732.574068333866, 4767.261074533453, 5114.616403769732, 5135.794568217267, 5144.202648589475, 5148.61385396093, 5166.948330516684, 5044.016416798726, 5174.508421699932, 5184.196449550288, 5188.0, 5209.739513024371, 4732.716037037754, 4747.905041899212, 4795.064962332347, 4796.472388037313, 4811.133995880705, 5241.580673546107, 5247.055530004636, 5251.081060814342, 5278.9208161877605, 5309.601779866448, 4962.057209130254, 4963.57809586182, 4965.553100220925, 5036.722980236123, 5038.395392552844, 5081.898362032739, 5105.463926287761, 5120.385553733576, 5130.692158470503, 5173.689578625294, 4986.650934434628, 5012.097822391932, 5018.799248030111, 5023.171176755867, 5076.517730815566, 4939.456659767423, 5029.748512574357, 5041.470645582234, 5092.643514953992, 5103.413107492612, 4339.7396156230725, 4357.106793107406, 4364.410804541346, 4377.1683380157665, 4413.205622987893, 3793.279276937373, 3818.4654148419245, 3825.387937929918, 3846.826892789831, 3865.4781604483037, 4345.652347812167, 4495.011097558532, 4514.0, 4545.5908968193025, 4573.451185857718, 5101.413337466165, 5132.178851383761, 5153.768080436389, 5154.123798954187, 5192.844214673491, 4536.138133754576, 4537.205988951986, 4538.88652783683, 4575.993281478136, 4585.472670642852, 4583.2666773316105, 4599.563041511051, 4644.651651126179, 4651.837185698484, 4664.277037059262, 4912.656114072052, 4913.0, 4926.8768280793265, 4931.235658472942, 4984.102861484967, 5140.43455219933, 5152.072626927189, 5176.145935920682, 5178.171492561172, 5218.086834803818, 4897.632677549127, 4920.40955085392, 4961.70229786214, 4992.80028798844, 5005.499450055111, 4997.600191984559, 5023.196288593954, 5029.119904016856, 5034.119029169954, 5083.034223497523, 5003.249512573143, 5096.031753966735, 5103.693778373309, 5113.079645663816, 5115.0, 4822.156122678447, 4944.28307895346, 4988.4263309719845, 5027.145385284583, 5073.467285934924, 4914.778834952364, 4916.483769204182, 4939.53074457926, 4952.182889823139, 4965.4289756677, 4755.762211889461, 4819.975900120477, 4846.757662116951, 4859.611231101574, 4905.092557876804, 4990.3762029746285, 5030.0694371541385, 5033.370828646419, 5089.185730283137, 5108.131617625087, 4819.373481447389, 4857.587105096107, 4867.683600565952, 4868.075065737498, 4868.196747536616], "value": 4701.940947675595, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.1565859040733, 600.8407771940435, 605.963642181469, 609.7652403824526, 615.4553220399947, 34213.486797698024, 35226.29547409053, 35282.0, 35283.4707479388, 35438.2912341753, 37970.0, 38778.0, 38806.0, 38864.0, 38922.221555568874, 7536.171021187665, 7791.532508049507, 7792.80517987052, 7807.609619519029, 7815.257550532719, 7682.53904765713, 7784.727534536292, 7809.648565814524, 7911.406644501657, 7954.761357159266, 7864.567448790314, 7885.723999660013, 7898.842023159534, 7912.643931023118, 7931.167227441093, 7761.185075567068, 7830.999999999972, 7839.64721587527, 7935.563544005077, 7948.046234451845, 7816.218378162138, 7854.410919181028, 7897.447178697494, 7922.564258965755, 7931.484453510503, 37747.0, 37925.0, 38456.0, 38592.80703596492, 38602.613973860185, 2513.54756143894, 3105.3634005028916, 3538.0, 3636.381815091441, 3722.758020728644, 25623.994966091053, 25719.357016074562, 26161.73838261612, 26442.206733798015, 26486.337841553923, 3188.4898416253286, 3232.7413806895393, 3270.9509357359657, 3306.801591904469, 3315.784474009206, 151885.0, 152651.23674381667, 153547.23226383908, 154601.22699386545, 154755.0, 53885.46114538883, 54195.72902135543, 54476.45523544714, 54485.1827222592, 54533.0, 63991.0, 65633.0, 66248.0, 66293.668531658, 66342.0, 13148.40832162555, 13210.0, 13245.337733113498, 13251.734965300833, 13291.601251962264, 10916.290441121302, 10965.671029869116, 10993.450327483593, 10996.945015274872, 11001.834972475419, 18836.81163188378, 18984.240630374905, 19044.571977044267, 19045.142968566448, 19132.23471061142, 6797.6601169941305, 6929.094499012711, 7059.258777828254, 7189.388901943394, 7265.818354541178, 880.8282384934876, 885.2342723544087, 959.8944116147218, 1011.9241056920761, 1019.7807471393686, 27852.442951140863, 28484.43031139407, 28597.0, 29084.854575726986, 29178.41643167125, 999.3853779925294, 1029.3926583315729, 1032.3547782635853, 1047.8218702820539, 1064.4677661169414, 15257.38970441192, 15270.160141192118, 15502.5349239523, 15634.3746250151, 15648.530544083696, 344389.0, 349540.0, 350364.0, 350446.0, 351278.0, 49863.50136498589, 50274.0, 50604.0, 50696.0, 50830.491695083314, 1203.8796120388067, 1224.7305592769576, 1234.4630085912656, 1264.431006047264, 1267.2143271171933, 26794.866025669748, 27887.0, 28056.71943280541, 28652.85673571619, 28738.281542960758, 43583.78208108939, 43842.56157438385, 44078.33882491829, 44101.55898440975, 44175.0, 317610.0, 317863.0, 319099.0, 320832.0, 320850.0, 25551.872240638677, 25722.356941075876, 25910.222693319232, 25985.740142599087, 26277.08030218933, 43095.78452107719, 43142.0, 43170.56829431791, 43797.34303985379, 44104.338434924146, 37240.6275937248, 37532.0, 37723.81138094292, 37943.0, 38409.231815364095, 35893.82053089718, 36535.08662283464, 36579.26841463209, 36646.0, 37772.811135945245, 32182.839085805357, 36550.26899462049, 36617.0, 37263.44104838484, 37411.0, 28585.571216432185, 29142.27144321409, 29178.708212917598, 29332.266693332836, 29357.706422936353, 22841.885790571607, 22972.77027229773, 23511.17710880111, 23622.29133126009, 24762.752372476043], "value": 17336.611792444564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.5110433093474, 384.8191350065469, 386.52457477302914, 401.4620408652405, 402.80463974972133, 13406.46374145033, 15178.62053448663, 16341.182940852968, 16584.751228731562, 16819.0, 15560.610984725388, 16025.358985640589, 16322.020678759283, 16411.343546258166, 16450.506484805446, 4804.231322988323, 4894.119058569465, 4961.206207006861, 5012.323336349601, 5049.091163590552, 4971.577415919651, 4994.650374473788, 4999.900001999958, 5002.674826136307, 5010.624203184776, 4811.711297322172, 4974.403071631391, 5034.723090230036, 5041.873953151164, 5062.797488100471, 4984.850454486371, 4999.675021123633, 5000.97499512502, 5051.26756620288, 5055.31753213317, 4395.120975804852, 4503.504614492404, 4514.6388288936805, 4532.0709254602725, 4567.063751930879, 15268.0, 18207.907525548377, 19308.4207473776, 19828.306009289605, 19858.60282794336, 1969.4485544047689, 1979.7525309336334, 2054.938351849447, 2108.8523803333774, 2424.9878750606313, 13381.531646392426, 13419.261940593264, 13487.595372138852, 13501.189928604315, 13567.253801040939, 1747.3796802135187, 1804.1340156724846, 1808.5569035586366, 1827.43349561635, 1849.2140840142886, 66932.33067669309, 68421.65789171022, 68703.0, 69593.65203174003, 69736.0, 9398.530073496298, 9525.761650985327, 9843.655472058443, 9888.851667224853, 10250.179985601135, 12050.216735912138, 13204.339783010812, 13794.793078103836, 13875.791863122062, 13882.375293111834, 7008.123984501937, 7262.20115787263, 7272.745453909193, 7299.781006569811, 7321.048263725682, 6831.59010459374, 6865.725370985105, 6970.65146742671, 6984.371406573433, 7019.403350715246, 6094.232672525007, 6206.968965155145, 6209.316975132731, 6213.37866213375, 6319.715612797435, 1796.568823482355, 1824.797480421851, 1836.375632285003, 1851.416803706855, 1852.2683540001624, 916.757059379265, 920.4891285336569, 942.3262367407336, 946.8958414574391, 974.7368210583245, 16593.83406165947, 16938.745918811226, 17299.74050389245, 17413.651726965643, 17434.47696569105, 906.2930913887178, 936.0545848692869, 937.7936853892132, 941.6939494664261, 990.65327135502, 9308.162265396011, 9369.765755856022, 9693.806123877483, 9828.606855725833, 9925.1067403934, 401570.0, 402891.0, 414261.0, 414806.0, 423582.0, 70641.64679176675, 76329.0, 79878.6006069966, 80569.59715201387, 81102.0, 970.403202030746, 970.9611615535299, 997.5211898288862, 1010.8736407949007, 1023.4524529376896, 15265.160416177217, 15284.541463756104, 15377.384904604138, 15447.691046179238, 15696.607584810472, 26246.475070498866, 28360.432791343646, 33175.83412082924, 33566.160845979044, 34356.14109647279, 38998.2200355997, 39954.200915982095, 41205.38191927184, 44361.11277774362, 45257.32114018226, 7401.814954625962, 7526.5860377679755, 7659.0, 7864.5281283123195, 7893.447458677838, 11909.0, 11921.403929803648, 11965.820512692491, 12032.939835300767, 12173.0, 10118.342307749972, 10134.797304054026, 10151.796964060824, 10198.949005254926, 10219.23355748307, 9819.459929703935, 10190.337628054152, 10217.897821021694, 10300.742481438025, 10416.531256093342, 8406.537640429591, 9491.240700744062, 10406.635767748092, 10559.68320950342, 10783.838242426213, 7513.248675132661, 7561.243875612615, 7679.462437629312, 7708.0, 8069.959650201711, 9109.635614575607, 10442.843357349799, 10465.319754215952, 10558.947205263925, 10787.946060269649], "value": 8240.941769057217, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.3806363263795, 1489.0916540910043, 1616.773651688763, 1776.0498133498581, 1805.1425572852888, 6773.559718618287, 7725.92274077259, 7860.724874629389, 7992.16082311357, 7993.680252789889, 7932.6826926922995, 7949.721759738411, 8008.079070906848, 8021.9197808022045, 8022.1576734442915, 2249.493863880626, 2268.8638681679067, 2273.5111950930545, 2273.6589511573316, 2276.1919518570917, 2219.6004719150546, 2222.9110835566557, 2278.0, 2287.553926984239, 2288.96566551501, 2242.4842286274165, 2254.537819746948, 2264.830137739668, 2282.3837563857746, 2285.7828506291876, 2215.8448908576406, 2217.5121473275854, 2226.365485836537, 2227.6992605998225, 2232.55348930213, 2219.6115679755976, 2233.832462565314, 2234.5642599693065, 2241.3724157236, 2243.23729931824, 8113.0, 8123.959380203061, 8127.187281271885, 8146.674133034671, 8189.303909167668, 4640.118377508263, 4746.311784791186, 4752.144613969484, 4777.546133117348, 4781.617470602343, 2910.4906641337893, 3049.8017628854277, 3056.404001219763, 3061.5254635531305, 3069.5088785794164, 1768.9557761055949, 1787.4101546489628, 1788.3830078622855, 1793.4798908316573, 1819.0086402910445, 10234.283600147992, 10395.532201050972, 10399.844002340047, 10417.531211095518, 10436.843447348296, 4155.563665815106, 4181.937270940877, 4313.956860431418, 4324.2648749712625, 4332.350147477903, 8464.576771161417, 8518.829623407497, 8553.700620478377, 8568.400211985227, 8604.741857744277, 4579.244424669959, 4600.102979918951, 4617.399738034102, 4620.976895115503, 4624.699394539344, 3807.3146833569667, 4221.873343799691, 4239.04621460169, 4316.6330861877095, 4420.9115817684105, 3509.94735078974, 3555.7866528008403, 3636.9818150909077, 3650.4341827016856, 3663.2307215484516, 1067.9946600267103, 1103.1119948441421, 1106.601623415586, 1107.0534692837668, 1112.4993752811267, 796.1600511460465, 823.2755175445569, 878.8154487557557, 889.621910687955, 916.5875356089787, 5284.81503147388, 5443.836684899459, 5631.0, 5669.744861481243, 5696.487316141567, 798.1419973528364, 850.4089657687848, 865.5023361567124, 906.3655441191192, 917.1928702741678, 3647.434647629622, 3734.533183352081, 3819.3316169670197, 3853.497136116917, 3942.113024569449, 9825.803483930282, 10043.397396156253, 10049.748756281006, 10055.29612927088, 10062.446565438824, 9894.0, 9966.352187107816, 10009.799804003878, 10014.949925250326, 10110.646127385506, 7144.464165187632, 7391.15001774792, 7503.5873026982945, 7596.0, 7615.961920190363, 5529.419410961952, 5568.359638641446, 5642.971785141048, 5658.943410565842, 5727.656340619409, 8950.68672596456, 9035.186833185046, 9134.451932884049, 9209.0, 9218.446893186161, 8579.485230886166, 8837.734867953972, 8897.555122243992, 8902.465852048897, 8904.554772261232, 6282.246130464374, 6687.465002799861, 6867.450603951772, 6877.277885821916, 7072.71709131629, 7338.596377199306, 7359.632018399166, 7435.442341824277, 7453.515521491086, 7460.7015719372785, 6553.049807777941, 6762.323767623395, 6810.046593476818, 6826.965865170642, 6878.518503704692, 6688.762578922915, 6760.08738820253, 6809.250982392032, 6840.965795170992, 6900.171979362509, 6187.566870319034, 6239.688015599293, 6261.906071408841, 6281.371862813682, 6290.559660823698, 4752.073345697556, 4785.377900872864, 4793.5685788279225, 4863.4650188479945, 4943.0361079590575, 4779.713217206979, 4926.162552366035, 4962.702237865596, 4964.230544265644, 4997.200447928314], "value": 4299.4373163753535, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.5660966171514, 318.2648082928434, 325.3915178615987, 326.36033374585816, 330.96855798699147, 5320.361556613207, 5325.334333208349, 5346.679199248048, 5399.217113518537, 5410.91883621745, 5313.760880760366, 5317.8404647860625, 5329.653572517784, 5334.119870221409, 5340.0, 3928.0, 4033.4353190553197, 4164.042270277838, 4171.374293855915, 4172.97913510432, 4175.269327867626, 4181.163767246548, 4181.519125300599, 4190.958090419087, 4192.413062171298, 4160.230357383879, 4180.749155050691, 4181.853635122771, 4184.8744537663915, 4188.81150348235, 4101.343784994401, 4147.543770185277, 4148.56440073791, 4155.524788700029, 4181.895452613679, 3633.727470439701, 3649.5620525537106, 3659.0486473517076, 3659.5425571803526, 3660.9267814643827, 5075.406756885025, 5087.313212716273, 5088.567471764904, 5093.923591146098, 5098.592112631018, 4393.934090988638, 4666.929996050062, 4777.737224452654, 4790.658615587641, 4794.208955522335, 5525.668459892419, 5542.418046105141, 5551.195076713854, 5557.027520183951, 5570.610057295991, 3880.805959702032, 3915.7650540967347, 3923.4507168996365, 3929.98035009826, 3932.980335098306, 5615.792604589992, 5878.0, 5881.794137205177, 5920.407959204088, 5943.55423343251, 3990.9424002639325, 4011.157656892027, 4015.3976903464713, 4035.7174997750462, 4041.5756345583877, 4020.6783457323345, 4027.8520621622697, 4058.2201192183447, 4059.5331536873637, 4087.1825634873144, 4561.931571026437, 4643.326717625993, 4653.302004699322, 4666.580007799314, 4666.883327916829, 5575.470330318613, 5590.077637189818, 5590.133529302964, 5620.409856965041, 5635.887282254332, 1375.2985977151725, 1396.3786115178648, 1398.880895283769, 1399.860013998592, 1403.6069900427692, 875.746033650247, 901.724973882972, 946.1342871272708, 961.6489981156967, 966.3815158298695, 4839.443464001614, 4861.708297502161, 4863.927041094315, 4934.309196712463, 4942.827001054946, 5718.942810571841, 5726.427357264323, 5750.683712395775, 5754.367019627837, 5772.451617096369, 4911.214205727067, 4992.2511623256805, 4998.650094493423, 5004.574611158019, 5049.267856160836, 3069.677683843209, 3100.5039193728894, 3104.62744470665, 3118.3139709263924, 3136.7766571037314, 5500.669959802424, 5534.584906132056, 5557.44425557441, 5567.944320556823, 5601.355844077902, 5860.3260625027815, 5946.970265148733, 6002.129691194752, 6004.489618382487, 6017.044460550339, 5437.537809286176, 5565.193047008162, 5576.749046292926, 5577.721113944368, 5602.327720673546, 5647.519960803378, 5799.795148517292, 5829.825105246679, 5830.76676932918, 5830.909617902518, 5673.631213971079, 5688.971555142198, 5697.0, 5731.5701322400155, 5740.253767010429, 5548.916766248429, 5549.944500555104, 5567.582431317586, 5572.108462645957, 5609.298837645294, 3926.1362500249897, 3955.4857868476915, 4024.8390064397095, 4027.617376349242, 4032.7580345179385, 5732.3121225453215, 5801.274840644919, 5812.564057695605, 5819.970900145472, 5824.970875145597, 5626.606137570331, 5631.409551606307, 5640.605157638925, 5643.746031428514, 5646.0, 5457.744718714638, 5583.664980101207, 5600.635958662674, 5633.126865335879, 5634.661920284796, 5259.079661059376, 5538.307711536058, 5556.083246264483, 5561.749721262634, 5563.912028824042, 5459.0, 5625.537360286273, 5630.943690563042, 5633.0987042073075, 5649.152627105967, 5483.588730845282, 5516.613837031369, 5529.723513824373, 5540.36285827135, 5541.418151094077], "value": 4212.602775459227, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.2430144580118, 772.1236396689762, 779.1429427629608, 792.04162962815, 807.8222790985989, 12116.878831211685, 12222.0, 12342.753144937096, 12357.629271121858, 12429.440675169617, 12403.875961240408, 12585.056120790954, 12651.0, 12710.618681439548, 12763.23420594765, 641.6503005861816, 771.9729809456657, 786.5005721366916, 805.472415567804, 811.2820154163549, 804.7304153108715, 811.2050190813006, 811.6225954930956, 811.7808191788243, 811.9391045671568, 839.0, 842.9789255268606, 844.0968164064453, 849.218718778722, 852.1606217875419, 835.1356346181703, 846.2595229174473, 847.0851480401183, 848.4103548034119, 848.8259906719107, 600.5255847880169, 608.4888693497439, 615.6552330694781, 617.0, 618.8916939535563, 11760.411979400995, 11865.288082714978, 11903.761924761542, 11966.282023078644, 11995.580154694544, 12980.870191298061, 13106.475740970349, 13148.934255328662, 13376.0, 13424.932875335659, 9075.18323350895, 9159.40463869853, 9177.128172823572, 9318.0, 9357.344985850994, 3274.6397896231397, 3288.3094550144497, 3293.7200337971303, 3321.7674762766615, 3348.0792781984906, 46212.76893615544, 46297.30554041692, 47425.0, 47891.281630775564, 48060.51939480595, 10237.846432303522, 10245.334053286513, 10347.120494757879, 10374.948125259325, 10548.525316360781, 16710.164491775362, 18392.08039598015, 18547.0, 18599.44201673952, 18677.906610467133, 6685.39831415175, 6738.19141702989, 6813.7955861324235, 6821.624810635363, 6932.168139823253, 3708.0915175782106, 3743.457198706227, 3779.9244015119543, 3792.943105853359, 3807.428885667172, 3036.149878034154, 3262.1844538865284, 3374.0, 3399.184195792992, 3399.9490007649906, 601.4466690644617, 604.3020311540179, 605.0742364182807, 608.5770389579288, 615.5844804756771, 515.5463192390672, 549.9285092937972, 551.6662419236385, 619.575590720358, 640.4460141977156, 7503.812404689927, 7757.72847950319, 7758.14660387357, 7813.218678132142, 7876.803079923047, 540.4460428061269, 582.6533212738414, 616.3928530397554, 619.4703528483172, 622.6730966242668, 3523.2777280657406, 3638.526991491089, 3691.667749902522, 3735.2716220336774, 3828.712846536521, 51543.7422812891, 52205.477945220824, 52212.73893630583, 52555.73722131365, 52596.055295852966, 46261.0, 46699.29951050737, 47076.293855592194, 47903.5209647906, 47928.0, 42947.78526107349, 43599.56400435955, 43632.3455148173, 43829.56170438319, 45170.09659806785, 6421.389967953037, 6676.632785196861, 6716.597004179765, 6953.6523173842115, 6963.234044255027, 28952.276193095342, 29108.854455727585, 29300.853495732386, 29842.104736857927, 30375.848120759256, 39641.60358396495, 39753.80123099366, 40395.79802100971, 41128.38307425451, 41214.38178427266, 11546.249493782878, 11646.359450230319, 11661.125415594033, 11777.764444711229, 12004.279743215435, 10839.024487796136, 11161.107111431229, 11272.098232141572, 11329.71675708114, 11396.601118960796, 11376.356936560038, 11405.258658187191, 11419.029382502247, 11427.371494567878, 11430.542778288775, 11126.721831954266, 11213.102951763676, 11274.436278186222, 11279.718007049561, 11514.53941842317, 9956.153726933291, 10846.837297440703, 10877.238593298709, 10933.343999360064, 11270.042046425817, 9098.226650734761, 9189.954050229973, 9318.440893546138, 9405.670801521914, 9425.0, 9535.713928582154, 9691.224702023963, 9714.659986900424, 9730.464824434725, 9874.654387096418], "value": 5991.3607286781125, "unit": "score"}], "name": "dromaeo_css", "value": 6463.358259510131, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 116.0, 116.0, 115.0, 126.0, 115.0, 113.0, 114.0, 114.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 145.0, 158.0, 195.0, 134.0, 161.0, 164.0, 138.0, 186.0, 135.0], "value": 157.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 166.0, 172.0, 162.0, 164.0, 162.0, 163.0, 165.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 165.0, 74.0, 77.0, 74.0, 77.0, 156.0, 78.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 149.0, 94.0, 94.0, 94.0, 140.0, 94.0, 94.0, 136.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 97.0, 100.0, 96.0, 96.0, 95.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 65.0, 64.0, 67.0, 66.0, 65.0, 87.0, 63.0, 65.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 64.0, 64.0, 64.0, 63.0, 69.0, 64.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 83.0, 84.0, 87.0, 87.0, 86.0, 85.0, 88.0, 87.0, 85.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 139.0, 144.0, 143.0, 137.0, 136.0, 139.0, 166.0, 150.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 171.0, 170.0, 182.0, 174.0, 168.0, 169.0, 171.0, 171.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 83.0, 75.0, 75.0, 74.0, 72.0, 73.0, 71.0, 73.0, 70.0], "value": 74.0, "unit": "score"}], "name": "kraken", "value": 1606.6999999999998, "alertThreshold": 2.0}]} 02:27:38 INFO - Return code: 0 02:27:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:27:38 ERROR - # TBPL SUCCESS # 02:27:38 INFO - Running post-action listener: _resource_record_post_action 02:27:38 INFO - Running post-run listener: _resource_record_post_run 02:27:39 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 519344128; Read time: 32; Write time: 397920 02:27:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233525248; Read time: 0; Write time: 215184 02:27:39 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 8192; Write bytes: 285818880; Read time: 32; Write time: 182736 02:27:39 INFO - Running post-run listener: _upload_blobber_files 02:27:39 INFO - Blob upload gear active. 02:27:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:27:39 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 02:27:39 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'] 02:27:39 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 02:27:40 INFO - (blobuploader) - INFO - Open directory for files ... 02:27:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:27:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:27:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:41 INFO - (blobuploader) - INFO - Done attempting. 02:27:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:27:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:27:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:41 INFO - (blobuploader) - INFO - Done attempting. 02:27:41 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:41 INFO - Return code: 0 02:27:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:27:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/456a94763d71bf2675e6e2a51c1451152fb65cfd71eece635b6c1b2ea6ae6ebf310c91cc8115c113e9a3e084eb4157bf19c14074fb315c1c824b297e55fb08e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39139eba14661c5cc09dfd6cc4adf6171e67ca33a63d7e77231090f373c51de3f46ba2ab5bb74b2b5a3027ad7b81a43d9ace344379d792e229b976c01a75c1c1"} 02:27:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:27:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:27:41 INFO - Contents: 02:27:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/456a94763d71bf2675e6e2a51c1451152fb65cfd71eece635b6c1b2ea6ae6ebf310c91cc8115c113e9a3e084eb4157bf19c14074fb315c1c824b297e55fb08e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39139eba14661c5cc09dfd6cc4adf6171e67ca33a63d7e77231090f373c51de3f46ba2ab5bb74b2b5a3027ad7b81a43d9ace344379d792e229b976c01a75c1c1"} 02:27:41 INFO - Running post-run listener: copy_logs_to_upload_dir 02:27:41 INFO - Copying logs to upload dir... 02:27:41 INFO - mkdir: /builds/slave/test/build/upload/logs 02:27:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.004342 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-14 02:27:41.524525) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 02:27:41.528144) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239 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/456a94763d71bf2675e6e2a51c1451152fb65cfd71eece635b6c1b2ea6ae6ebf310c91cc8115c113e9a3e084eb4157bf19c14074fb315c1c824b297e55fb08e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39139eba14661c5cc09dfd6cc4adf6171e67ca33a63d7e77231090f373c51de3f46ba2ab5bb74b2b5a3027ad7b81a43d9ace344379d792e229b976c01a75c1c1"} build_url:https://queue.taskcluster.net/v1/task/GGJkIWOkRkyb98NSEyzTpw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/GGJkIWOkRkyb98NSEyzTpw/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/456a94763d71bf2675e6e2a51c1451152fb65cfd71eece635b6c1b2ea6ae6ebf310c91cc8115c113e9a3e084eb4157bf19c14074fb315c1c824b297e55fb08e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/39139eba14661c5cc09dfd6cc4adf6171e67ca33a63d7e77231090f373c51de3f46ba2ab5bb74b2b5a3027ad7b81a43d9ace344379d792e229b976c01a75c1c1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 02:27:41.552152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:27:41.552459) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1460624003.840614-949678239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 02:27:41.635542) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 02:27:41.635891) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 02:27:41.636188) ========= ========= Total master_lag: 0.26 =========