builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1460403897.99 results: success (0) buildid: 20160411115110 builduid: 77a57e7e5707488bae456943035a0866 revision: 88a5069742fee445e11923ad865f8a9bf88a25eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 12:44:57.986856) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 12:44:57.987430) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 12:44:57.987736) ========= 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=cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006448 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 12:44:58.010828) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 12:44:58.011142) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 12:44:58.025244) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:44:58.025670) ========= 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=cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004669 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:44:58.075632) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 12:44:58.075936) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 12:44:58.076304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-11 12:44:58.076583) ========= 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=cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-11 12:44:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 10.7M=0.001s 2016-04-11 12:45:01 (10.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=1.399337 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-11 12:44:59.488654) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:44:59.488967) ========= 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=cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016352 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 12:44:59.538345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-11 12:44:59.538695) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 88a5069742fee445e11923ad865f8a9bf88a25eb --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 88a5069742fee445e11923ad865f8a9bf88a25eb --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=cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-11 12:45:01,207 truncating revision to first 12 chars 2016-04-11 12:45:01,207 Setting DEBUG logging. 2016-04-11 12:45:01,207 attempt 1/10 2016-04-11 12:45:01,207 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/88a5069742fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 12:45:03,044 unpacking tar archive at: fx-team-88a5069742fe/testing/mozharness/ program finished with exit code 0 elapsedTime=3.464288 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-11 12:45:03.017285) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 12:45:03.017722) ========= echo 88a5069742fee445e11923ad865f8a9bf88a25eb in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'88a5069742fee445e11923ad865f8a9bf88a25eb'] 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=cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 88a5069742fee445e11923ad865f8a9bf88a25eb program finished with exit code 0 elapsedTime=0.004724 script_repo_revision: '88a5069742fee445e11923ad865f8a9bf88a25eb' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 12:45:03.069223) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 12:45:03.069546) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 12:45:03.082155) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2016-04-11 12:45:03.082569) ========= /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=cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:45:04 INFO - MultiFileLogger online at 20160411 12:45:04 in /builds/slave/test 12:45: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 12:45:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:45:04 INFO - {'append_to_log': False, 12:45:04 INFO - 'base_work_dir': '/builds/slave/test', 12:45:04 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:45:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:45:04 INFO - 'branch': 'Fx-Team-Non-PGO', 12:45:04 INFO - 'buildbot_json_path': 'buildprops.json', 12:45:04 INFO - 'config_files': ('talos/linux_config.py',), 12:45:04 INFO - 'default_actions': ('clobber', 12:45:04 INFO - 'read-buildbot-config', 12:45:04 INFO - 'download-and-extract', 12:45:04 INFO - 'populate-webroot', 12:45:04 INFO - 'create-virtualenv', 12:45:04 INFO - 'install', 12:45:04 INFO - 'run-tests'), 12:45:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:45:04 INFO - 'download_minidump_stackwalk': True, 12:45:04 INFO - 'download_symbols': 'ondemand', 12:45:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:45:04 INFO - 'tooltool.py': '/tools/tooltool.py', 12:45:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:45:04 INFO - '/tools/misc-python/virtualenv.py')}, 12:45:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:45:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:45:04 INFO - 'installer_path': 'installer.exe', 12:45:04 INFO - 'log_level': 'info', 12:45:04 INFO - 'log_name': 'talos', 12:45:04 INFO - 'log_to_console': True, 12:45:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:45:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:45:04 INFO - 'opt_config_files': (), 12:45:04 INFO - 'pip_index': False, 12:45:04 INFO - 'sps_profile': False, 12:45:04 INFO - 'sps_profile_interval': 0, 12:45:04 INFO - 'suite': 'dromaeojs-e10s', 12:45:04 INFO - 'system_bits': '32', 12:45:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:45:04 INFO - 'title': 'talos-linux64-ix-054', 12:45:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:45:04 INFO - 'use_talos_json': True, 12:45:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:45:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:45:04 INFO - 'work_dir': 'build'} 12:45:04 INFO - ##### 12:45:04 INFO - ##### Running clobber step. 12:45:04 INFO - ##### 12:45:04 INFO - Running pre-action listener: _resource_record_pre_action 12:45:04 INFO - Running main action method: clobber 12:45:04 INFO - rmtree: /builds/slave/test/build 12:45:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:45:05 INFO - Running post-action listener: _resource_record_post_action 12:45:05 INFO - ##### 12:45:05 INFO - ##### Running read-buildbot-config step. 12:45:05 INFO - ##### 12:45:05 INFO - Running pre-action listener: _resource_record_pre_action 12:45:05 INFO - Running main action method: read_buildbot_config 12:45:05 INFO - Using buildbot properties: 12:45:05 INFO - { 12:45:05 INFO - "project": "", 12:45:05 INFO - "product": "firefox", 12:45:05 INFO - "script_repo_revision": "production", 12:45:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:45:05 INFO - "repository": "", 12:45:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:45:05 INFO - "buildid": "20160411115110", 12:45:05 INFO - "pgo_build": "False", 12:45:05 INFO - "basedir": "/builds/slave/test", 12:45:05 INFO - "buildnumber": 1137, 12:45:05 INFO - "slavename": "talos-linux64-ix-054", 12:45:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:45:05 INFO - "platform": "ubuntu64_hw", 12:45:05 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:45:05 INFO - "branch": "fx-team", 12:45:05 INFO - "repo_path": "integration/fx-team", 12:45:05 INFO - "revision": "88a5069742fee445e11923ad865f8a9bf88a25eb", 12:45:05 INFO - "stage_platform": "linux64", 12:45:05 INFO - "builduid": "77a57e7e5707488bae456943035a0866", 12:45:05 INFO - "slavebuilddir": "test" 12:45:05 INFO - } 12:45:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:45:05 INFO - Running post-action listener: _resource_record_post_action 12:45:05 INFO - ##### 12:45:05 INFO - ##### Running download-and-extract step. 12:45:05 INFO - ##### 12:45:05 INFO - Running pre-action listener: _resource_record_pre_action 12:45:05 INFO - Running main action method: download_and_extract 12:45:05 INFO - mkdir: /builds/slave/test/build/tests 12:45: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')]} 12:45:05 INFO - https://queue.taskcluster.net/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:45:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:45:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:45:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:45:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:45:08 INFO - Downloaded 1361 bytes. 12:45:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:45:08 INFO - Using the following test package requirements: 12:45:08 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:45:08 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:45:08 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:45:08 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:08 INFO - u'jsshell-linux-x86_64.zip'], 12:45:08 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:45:08 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:45:08 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:45:08 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:45:08 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:45:08 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:45:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:45:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:08 INFO - https://queue.taskcluster.net/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:45:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:45:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:45:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:45:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:45:21 INFO - Downloaded 22190501 bytes. 12:45:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:45:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:45:22 INFO - Return code: 0 12:45:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:22 INFO - https://queue.taskcluster.net/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:45:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:45:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:45:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:45:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:45:37 INFO - Downloaded 22190501 bytes. 12:45:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:45:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:45:39 INFO - Return code: 0 12:45: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')]} 12:45:39 INFO - https://queue.taskcluster.net/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:45:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:45:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:45:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:45:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:45:46 INFO - Downloaded 10841046 bytes. 12:45:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:45:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:45:46 INFO - Return code: 0 12:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:45:46 INFO - https://queue.taskcluster.net/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:45:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:45:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:45:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:45:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:45:59 INFO - Downloaded 54097043 bytes. 12:45:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:45:59 INFO - mkdir: /builds/slave/test/properties 12:45:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:45:59 INFO - Writing to file /builds/slave/test/properties/build_url 12:45:59 INFO - Contents: 12:45:59 INFO - build_url:https://queue.taskcluster.net/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:46:00 INFO - Running post-action listener: _resource_record_post_action 12:46:00 INFO - Running post-action listener: set_extra_try_arguments 12:46:00 INFO - ##### 12:46:00 INFO - ##### Running populate-webroot step. 12:46:00 INFO - ##### 12:46:00 INFO - Running pre-action listener: _resource_record_pre_action 12:46:00 INFO - Running main action method: populate_webroot 12:46:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:46:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:46:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:46:00 INFO - '--tppagecycles', 12:46:00 INFO - '7'], 12:46:00 INFO - 'tests': ['tsvgm']}}, 12:46:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:46:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:46:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:46:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:46:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:46:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:46:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:00 INFO - 'talos_options': ['--disable-e10s'], 12:46:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:46:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:46:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:00 INFO - 'talos_options': ['--disable-e10s'], 12:46:00 INFO - 'tests': ['damp', 'tps']}, 12:46:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:00 INFO - 'tests': ['damp', 'tps']}, 12:46:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:46:00 INFO - 'tests': ['dromaeo_dom']}, 12:46:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:46:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:46:00 INFO - 'tests': ['a11yr', 12:46:00 INFO - 'ts_paint', 12:46:00 INFO - 'tpaint', 12:46:00 INFO - 'sessionrestore', 12:46:00 INFO - 'sessionrestore_no_auto_restore', 12:46:00 INFO - 'tabpaint']}, 12:46:00 INFO - 'other-e10s': {'tests': ['a11yr', 12:46:00 INFO - 'ts_paint', 12:46:00 INFO - 'tpaint', 12:46:00 INFO - 'sessionrestore', 12:46:00 INFO - 'sessionrestore_no_auto_restore', 12:46:00 INFO - 'tabpaint']}, 12:46:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:46:00 INFO - 'ts_paint', 12:46:00 INFO - 'tpaint', 12:46:00 INFO - 'sessionrestore', 12:46:00 INFO - 'sessionrestore_no_auto_restore', 12:46:00 INFO - 'tabpaint']}, 12:46:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:46:00 INFO - 'ts_paint', 12:46:00 INFO - 'tpaint', 12:46:00 INFO - 'sessionrestore', 12:46:00 INFO - 'sessionrestore_no_auto_restore', 12:46:00 INFO - 'tabpaint']}, 12:46:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:46:00 INFO - 'tests': ['a11yr', 12:46:00 INFO - 'ts_paint', 12:46:00 INFO - 'tpaint', 12:46:00 INFO - 'sessionrestore', 12:46:00 INFO - 'sessionrestore_no_auto_restore', 12:46:00 INFO - 'tabpaint']}, 12:46:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:46:00 INFO - 'tests': ['a11yr', 12:46:00 INFO - 'ts_paint', 12:46:00 INFO - 'tpaint', 12:46:00 INFO - 'sessionrestore', 12:46:00 INFO - 'sessionrestore_no_auto_restore', 12:46:00 INFO - 'tabpaint']}, 12:46:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:46:00 INFO - 'tests': ['tsvgx', 12:46:00 INFO - 'tsvgr_opacity', 12:46:00 INFO - 'tart', 12:46:00 INFO - 'tscrollx', 12:46:00 INFO - 'cart']}, 12:46:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:46:00 INFO - 'tsvgr_opacity', 12:46:00 INFO - 'tart', 12:46:00 INFO - 'tscrollx', 12:46:00 INFO - 'cart']}, 12:46:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:00 INFO - 'talos_options': ['--disable-e10s'], 12:46:00 INFO - 'tests': ['tp5o']}, 12:46:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:00 INFO - 'tests': ['tp5o']}, 12:46:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:00 INFO - 'talos_options': ['--disable-e10s', 12:46:00 INFO - '--xperf_path', 12:46:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:46:00 INFO - 'tests': ['tp5n']}, 12:46:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:46:00 INFO - 'talos_options': ['--xperf_path', 12:46:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:46:00 INFO - 'tests': ['tp5n']}}, 12:46:00 INFO - 'talos.zip': {'path': '', 12:46:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:46:00 INFO - Running post-action listener: _resource_record_post_action 12:46:00 INFO - ##### 12:46:00 INFO - ##### Running create-virtualenv step. 12:46:00 INFO - ##### 12:46:00 INFO - Running pre-action listener: _resource_record_pre_action 12:46:00 INFO - Running main action method: create_virtualenv 12:46:00 INFO - Creating virtualenv /builds/slave/test/build/venv 12:46:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:46:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:46:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:46:01 INFO - Using real prefix '/usr' 12:46:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:46:01 INFO - Installing distribute.............................................................................................................................................................................................done. 12:46:03 INFO - Installing pip.................done. 12:46:03 INFO - Return code: 0 12:46:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47aea75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2384410>, '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 0x2385310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:46:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:46:03 INFO - Using env: {'DISPLAY': ':0', 12:46:03 INFO - 'HOME': '/home/cltbld', 12:46:03 INFO - 'LANG': 'en_US.UTF-8', 12:46:03 INFO - 'LANGUAGE': 'en_US:en', 12:46:03 INFO - 'LOGNAME': 'cltbld', 12:46:03 INFO - 'MAIL': '/var/mail/cltbld', 12:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:03 INFO - 'MOZ_NO_REMOTE': '1', 12:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:03 INFO - 'NO_EM_RESTART': '1', 12:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:03 INFO - 'PWD': '/builds/slave/test', 12:46:03 INFO - 'SHELL': '/bin/bash', 12:46:03 INFO - 'SHLVL': '1', 12:46:03 INFO - 'TERM': 'linux', 12:46:03 INFO - 'TMOUT': '86400', 12:46:03 INFO - 'USER': 'cltbld', 12:46:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 12:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:03 INFO - '_': '/tools/buildbot/bin/python'} 12:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:46:03 INFO - Cleaning up... 12:46:03 INFO - Return code: 0 12:46:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f47aea75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2384410>, '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 0x2385310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:46:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:46:03 INFO - Using env: {'DISPLAY': ':0', 12:46:03 INFO - 'HOME': '/home/cltbld', 12:46:03 INFO - 'LANG': 'en_US.UTF-8', 12:46:03 INFO - 'LANGUAGE': 'en_US:en', 12:46:03 INFO - 'LOGNAME': 'cltbld', 12:46:03 INFO - 'MAIL': '/var/mail/cltbld', 12:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:03 INFO - 'MOZ_NO_REMOTE': '1', 12:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:03 INFO - 'NO_EM_RESTART': '1', 12:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:03 INFO - 'PWD': '/builds/slave/test', 12:46:03 INFO - 'SHELL': '/bin/bash', 12:46:03 INFO - 'SHLVL': '1', 12:46:03 INFO - 'TERM': 'linux', 12:46:03 INFO - 'TMOUT': '86400', 12:46:03 INFO - 'USER': 'cltbld', 12:46:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 12:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:03 INFO - '_': '/tools/buildbot/bin/python'} 12:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:04 INFO - Downloading/unpacking psutil>=0.7.1 12:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:46:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:46:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:46:08 INFO - Installing collected packages: psutil 12:46:08 INFO - Running setup.py install for psutil 12:46:08 INFO - building 'psutil._psutil_linux' extension 12:46:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:46:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:46:08 INFO - building 'psutil._psutil_posix' extension 12:46:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:46:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:46:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:46:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:46:09 INFO - Successfully installed psutil 12:46:09 INFO - Cleaning up... 12:46:09 INFO - Return code: 0 12:46:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:46: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')]} 12:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46: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')]} 12:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:09 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 0x7f47aea75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2384410>, '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 0x2385310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:46:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:46:09 INFO - Using env: {'DISPLAY': ':0', 12:46:09 INFO - 'HOME': '/home/cltbld', 12:46:09 INFO - 'LANG': 'en_US.UTF-8', 12:46:09 INFO - 'LANGUAGE': 'en_US:en', 12:46:09 INFO - 'LOGNAME': 'cltbld', 12:46:09 INFO - 'MAIL': '/var/mail/cltbld', 12:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:09 INFO - 'MOZ_NO_REMOTE': '1', 12:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:09 INFO - 'NO_EM_RESTART': '1', 12:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:09 INFO - 'PWD': '/builds/slave/test', 12:46:09 INFO - 'SHELL': '/bin/bash', 12:46:09 INFO - 'SHLVL': '1', 12:46:09 INFO - 'TERM': 'linux', 12:46:09 INFO - 'TMOUT': '86400', 12:46:09 INFO - 'USER': 'cltbld', 12:46:09 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 12:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:09 INFO - '_': '/tools/buildbot/bin/python'} 12:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:46:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:46:15 INFO - Installing collected packages: mozsystemmonitor 12:46:15 INFO - Running setup.py install for mozsystemmonitor 12:46:15 INFO - Successfully installed mozsystemmonitor 12:46:15 INFO - Cleaning up... 12:46:15 INFO - Return code: 0 12:46:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:15 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 0x7f47aea75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2384410>, '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 0x2385310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:46:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:46:15 INFO - Using env: {'DISPLAY': ':0', 12:46:15 INFO - 'HOME': '/home/cltbld', 12:46:15 INFO - 'LANG': 'en_US.UTF-8', 12:46:15 INFO - 'LANGUAGE': 'en_US:en', 12:46:15 INFO - 'LOGNAME': 'cltbld', 12:46:15 INFO - 'MAIL': '/var/mail/cltbld', 12:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:15 INFO - 'MOZ_NO_REMOTE': '1', 12:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:15 INFO - 'NO_EM_RESTART': '1', 12:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:15 INFO - 'PWD': '/builds/slave/test', 12:46:15 INFO - 'SHELL': '/bin/bash', 12:46:15 INFO - 'SHLVL': '1', 12:46:15 INFO - 'TERM': 'linux', 12:46:15 INFO - 'TMOUT': '86400', 12:46:15 INFO - 'USER': 'cltbld', 12:46:15 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 12:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:15 INFO - '_': '/tools/buildbot/bin/python'} 12:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:15 INFO - Downloading/unpacking blobuploader==1.2.4 12:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:21 INFO - Downloading blobuploader-1.2.4.tar.gz 12:46:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:46:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:46: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 12:46: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 12:46: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 12:46: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 12:46: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 12:46: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 12:46:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:46:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:23 INFO - Downloading docopt-0.6.1.tar.gz 12:46:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:46:23 INFO - Installing collected packages: blobuploader, requests, docopt 12:46:23 INFO - Running setup.py install for blobuploader 12:46:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:46:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:46:23 INFO - Running setup.py install for requests 12:46:24 INFO - Running setup.py install for docopt 12:46:24 INFO - Successfully installed blobuploader requests docopt 12:46:24 INFO - Cleaning up... 12:46:24 INFO - Return code: 0 12:46:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:24 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 0x7f47aea75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2384410>, '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 0x2385310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:46:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:46:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:46:24 INFO - Using env: {'DISPLAY': ':0', 12:46:24 INFO - 'HOME': '/home/cltbld', 12:46:24 INFO - 'LANG': 'en_US.UTF-8', 12:46:24 INFO - 'LANGUAGE': 'en_US:en', 12:46:24 INFO - 'LOGNAME': 'cltbld', 12:46:24 INFO - 'MAIL': '/var/mail/cltbld', 12:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:24 INFO - 'MOZ_NO_REMOTE': '1', 12:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:24 INFO - 'NO_EM_RESTART': '1', 12:46:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:24 INFO - 'PWD': '/builds/slave/test', 12:46:24 INFO - 'SHELL': '/bin/bash', 12:46:24 INFO - 'SHLVL': '1', 12:46:24 INFO - 'TERM': 'linux', 12:46:24 INFO - 'TMOUT': '86400', 12:46:24 INFO - 'USER': 'cltbld', 12:46:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 12:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:24 INFO - '_': '/tools/buildbot/bin/python'} 12:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:46:24 INFO - Running setup.py (path:/tmp/pip-nclYwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:46:24 INFO - Running setup.py (path:/tmp/pip-_QfzIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:46:24 INFO - Running setup.py (path:/tmp/pip-dp0YMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:46:24 INFO - Running setup.py (path:/tmp/pip-nBzT7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:46:24 INFO - Running setup.py (path:/tmp/pip-6Hevoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:46:24 INFO - Running setup.py (path:/tmp/pip-42MEmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:46:25 INFO - Running setup.py (path:/tmp/pip-FUMSEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:46:25 INFO - Running setup.py (path:/tmp/pip-s9iEaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:46:25 INFO - Running setup.py (path:/tmp/pip-StQttm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:46:25 INFO - Running setup.py (path:/tmp/pip-LuiHyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:46:25 INFO - Running setup.py (path:/tmp/pip-SofQ1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:46:25 INFO - Running setup.py (path:/tmp/pip-_b52lB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:46:25 INFO - Running setup.py (path:/tmp/pip-NTcYWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:46:25 INFO - Running setup.py (path:/tmp/pip-owKGwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:46:25 INFO - Running setup.py (path:/tmp/pip-cLwoZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:46:25 INFO - Running setup.py (path:/tmp/pip-lSXqsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:46:25 INFO - Running setup.py (path:/tmp/pip-5Gg2i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:46:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:46:25 INFO - Running setup.py install for manifestparser 12:46:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:46:25 INFO - Running setup.py install for mozcrash 12:46:26 INFO - Running setup.py install for mozdebug 12:46:26 INFO - Running setup.py install for mozdevice 12:46:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:46:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:46:26 INFO - Running setup.py install for mozfile 12:46:26 INFO - Running setup.py install for mozhttpd 12:46:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:46:26 INFO - Running setup.py install for mozinfo 12:46:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:46:26 INFO - Running setup.py install for mozInstall 12:46:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:46:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:46:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:46:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:46:26 INFO - Running setup.py install for mozleak 12:46:26 INFO - Running setup.py install for mozlog 12:46:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:46:26 INFO - Running setup.py install for moznetwork 12:46:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:46:26 INFO - Running setup.py install for mozprocess 12:46:27 INFO - Running setup.py install for mozprofile 12:46:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:46:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:46:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:46:27 INFO - Running setup.py install for mozrunner 12:46:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:46:27 INFO - Running setup.py install for mozscreenshot 12:46:27 INFO - Running setup.py install for moztest 12:46:27 INFO - Running setup.py install for mozversion 12:46:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:46:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:46:27 INFO - Cleaning up... 12:46:27 INFO - Return code: 0 12:46:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:27 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 0x7f47aea75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2384410>, '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 0x2385310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:46:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:46:27 INFO - Using env: {'DISPLAY': ':0', 12:46:27 INFO - 'HOME': '/home/cltbld', 12:46:27 INFO - 'LANG': 'en_US.UTF-8', 12:46:27 INFO - 'LANGUAGE': 'en_US:en', 12:46:27 INFO - 'LOGNAME': 'cltbld', 12:46:27 INFO - 'MAIL': '/var/mail/cltbld', 12:46:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:27 INFO - 'MOZ_NO_REMOTE': '1', 12:46:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:27 INFO - 'NO_EM_RESTART': '1', 12:46:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:27 INFO - 'PWD': '/builds/slave/test', 12:46:27 INFO - 'SHELL': '/bin/bash', 12:46:27 INFO - 'SHLVL': '1', 12:46:27 INFO - 'TERM': 'linux', 12:46:27 INFO - 'TMOUT': '86400', 12:46:27 INFO - 'USER': 'cltbld', 12:46:27 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 12:46:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:27 INFO - '_': '/tools/buildbot/bin/python'} 12:46:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:46:27 INFO - Running setup.py (path:/tmp/pip-QKeUAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:46:27 INFO - Running setup.py (path:/tmp/pip-Tm3UH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:46:28 INFO - Running setup.py (path:/tmp/pip-V2rirz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:46:28 INFO - Running setup.py (path:/tmp/pip-APueB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:46:28 INFO - Running setup.py (path:/tmp/pip-gTSVT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:46:28 INFO - Running setup.py (path:/tmp/pip-xEY1Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:46:28 INFO - Running setup.py (path:/tmp/pip-qZx2vK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:46:28 INFO - Running setup.py (path:/tmp/pip-O_55E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:46:28 INFO - Running setup.py (path:/tmp/pip-RdwiBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:46:28 INFO - Running setup.py (path:/tmp/pip-dEPftX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:46:28 INFO - Running setup.py (path:/tmp/pip-t_HvJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:46:28 INFO - Running setup.py (path:/tmp/pip-8cQQNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:46:28 INFO - Running setup.py (path:/tmp/pip-5ZOKPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:46:28 INFO - Running setup.py (path:/tmp/pip-OfxsUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:46:28 INFO - Running setup.py (path:/tmp/pip-SiybtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:46:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:46:28 INFO - Running setup.py (path:/tmp/pip-xik_2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:46:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:46:29 INFO - Running setup.py (path:/tmp/pip-ll1_dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:46:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:46: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 12:46: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 12:46: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 12:46: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 12:46: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 12:46: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 12:46:34 INFO - Downloading blessings-1.6.tar.gz 12:46:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:46:34 INFO - Installing collected packages: blessings 12:46:34 INFO - Running setup.py install for blessings 12:46:34 INFO - Successfully installed blessings 12:46:34 INFO - Cleaning up... 12:46:34 INFO - Return code: 0 12:46:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:46:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:46:34 INFO - Reading from file tmpfile_stdout 12:46:34 INFO - Current package versions: 12:46:34 INFO - argparse == 1.2.1 12:46:34 INFO - blessings == 1.6 12:46:34 INFO - blobuploader == 1.2.4 12:46:34 INFO - docopt == 0.6.1 12:46:34 INFO - manifestparser == 1.1 12:46:34 INFO - mozInstall == 1.12 12:46:34 INFO - mozcrash == 0.17 12:46:34 INFO - mozdebug == 0.1 12:46:34 INFO - mozdevice == 0.48 12:46:34 INFO - mozfile == 1.2 12:46:34 INFO - mozhttpd == 0.7 12:46:34 INFO - mozinfo == 0.9 12:46:34 INFO - mozleak == 0.1 12:46:34 INFO - mozlog == 3.1 12:46:34 INFO - moznetwork == 0.27 12:46:34 INFO - mozprocess == 0.22 12:46:34 INFO - mozprofile == 0.28 12:46:34 INFO - mozrunner == 6.11 12:46:34 INFO - mozscreenshot == 0.1 12:46:34 INFO - mozsystemmonitor == 0.0 12:46:34 INFO - moztest == 0.7 12:46:34 INFO - mozversion == 1.4 12:46:34 INFO - psutil == 3.1.1 12:46:34 INFO - requests == 1.2.3 12:46:34 INFO - wsgiref == 0.1.2 12:46:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:34 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 0x7f47aea75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2384410>, '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 0x2385310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:46:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:46:34 INFO - Using env: {'DISPLAY': ':0', 12:46:34 INFO - 'HOME': '/home/cltbld', 12:46:34 INFO - 'LANG': 'en_US.UTF-8', 12:46:34 INFO - 'LANGUAGE': 'en_US:en', 12:46:34 INFO - 'LOGNAME': 'cltbld', 12:46:34 INFO - 'MAIL': '/var/mail/cltbld', 12:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:34 INFO - 'MOZ_NO_REMOTE': '1', 12:46:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:34 INFO - 'NO_EM_RESTART': '1', 12:46:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:34 INFO - 'PWD': '/builds/slave/test', 12:46:34 INFO - 'SHELL': '/bin/bash', 12:46:34 INFO - 'SHLVL': '1', 12:46:34 INFO - 'TERM': 'linux', 12:46:34 INFO - 'TMOUT': '86400', 12:46:34 INFO - 'USER': 'cltbld', 12:46:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 12:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:34 INFO - '_': '/tools/buildbot/bin/python'} 12:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:46:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:46:34 INFO - Cleaning up... 12:46:34 INFO - Return code: 0 12:46:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:34 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 0x7f47aea75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2384410>, '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 0x2385310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:46:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:46:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:46:34 INFO - Using env: {'DISPLAY': ':0', 12:46:34 INFO - 'HOME': '/home/cltbld', 12:46:34 INFO - 'LANG': 'en_US.UTF-8', 12:46:34 INFO - 'LANGUAGE': 'en_US:en', 12:46:34 INFO - 'LOGNAME': 'cltbld', 12:46:34 INFO - 'MAIL': '/var/mail/cltbld', 12:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:34 INFO - 'MOZ_NO_REMOTE': '1', 12:46:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:34 INFO - 'NO_EM_RESTART': '1', 12:46:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:34 INFO - 'PWD': '/builds/slave/test', 12:46:34 INFO - 'SHELL': '/bin/bash', 12:46:34 INFO - 'SHLVL': '1', 12:46:34 INFO - 'TERM': 'linux', 12:46:34 INFO - 'TMOUT': '86400', 12:46:34 INFO - 'USER': 'cltbld', 12:46:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 12:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:34 INFO - '_': '/tools/buildbot/bin/python'} 12:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:35 INFO - Downloading/unpacking jsonschema 12:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:46:41 INFO - Downloading/unpacking functools32 (from jsonschema) 12:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:41 INFO - Downloading functools32-3.2.3-2.tar.gz 12:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:46:41 INFO - warning: no files found matching '*.txt' 12:46:41 INFO - no previously-included directories found matching 'build' 12:46:41 INFO - no previously-included directories found matching 'dist' 12:46:41 INFO - no previously-included directories found matching '.git*' 12:46:41 INFO - Installing collected packages: jsonschema, functools32 12:46:41 INFO - Running setup.py install for functools32 12:46:41 INFO - warning: no files found matching '*.txt' 12:46:41 INFO - no previously-included directories found matching 'build' 12:46:41 INFO - no previously-included directories found matching 'dist' 12:46:41 INFO - no previously-included directories found matching '.git*' 12:46:41 INFO - Successfully installed jsonschema functools32 12:46:41 INFO - Cleaning up... 12:46:41 INFO - Return code: 0 12:46:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:46:41 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 0x7f47aea75f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x222a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22f55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2384410>, '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 0x2385310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:46:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:46:41 INFO - Using env: {'DISPLAY': ':0', 12:46:41 INFO - 'HOME': '/home/cltbld', 12:46:41 INFO - 'LANG': 'en_US.UTF-8', 12:46:41 INFO - 'LANGUAGE': 'en_US:en', 12:46:41 INFO - 'LOGNAME': 'cltbld', 12:46:41 INFO - 'MAIL': '/var/mail/cltbld', 12:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:46:41 INFO - 'MOZ_NO_REMOTE': '1', 12:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:46:41 INFO - 'NO_EM_RESTART': '1', 12:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:46:41 INFO - 'PWD': '/builds/slave/test', 12:46:41 INFO - 'SHELL': '/bin/bash', 12:46:41 INFO - 'SHLVL': '1', 12:46:41 INFO - 'TERM': 'linux', 12:46:41 INFO - 'TMOUT': '86400', 12:46:41 INFO - 'USER': 'cltbld', 12:46:41 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 12:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:46:41 INFO - '_': '/tools/buildbot/bin/python'} 12:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:46:41 INFO - Downloading/unpacking flake8 12:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:46:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:46:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:46:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:46:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:46:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:46:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:46:48 INFO - no previously-included directories found matching 'docs/_build' 12:46:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:46:48 INFO - Running setup.py install for pep8 12:46:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:46:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:46:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:46:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:46:48 INFO - no previously-included directories found matching 'docs/_build' 12:46:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:46:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:46:48 INFO - Cleaning up... 12:46:48 INFO - Return code: 0 12:46:48 INFO - Running post-action listener: _resource_record_post_action 12:46:48 INFO - Running post-action listener: _start_resource_monitoring 12:46:48 INFO - Starting resource monitoring. 12:46:48 INFO - ##### 12:46:48 INFO - ##### Running install step. 12:46:48 INFO - ##### 12:46:48 INFO - Running pre-action listener: _resource_record_pre_action 12:46:48 INFO - Running main action method: install 12:46:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:46:48 INFO - Reading from file tmpfile_stdout 12:46:48 INFO - Detecting whether we're running mozinstall >=1.0... 12:46:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:46:48 INFO - Reading from file tmpfile_stdout 12:46:48 INFO - Output received: 12:46:48 INFO - Usage: mozinstall [options] installer 12:46:48 INFO - Options: 12:46:48 INFO - -h, --help show this help message and exit 12:46:48 INFO - -d DEST, --destination=DEST 12:46:48 INFO - Directory to install application into. [default: 12:46:48 INFO - "/builds/slave/test"] 12:46:48 INFO - --app=APP Application being installed. [default: firefox] 12:46:48 INFO - mkdir: /builds/slave/test/build/application 12:46:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:47:04 INFO - Reading from file tmpfile_stdout 12:47:04 INFO - Output received: 12:47:04 INFO - /builds/slave/test/build/application/firefox/firefox 12:47:04 INFO - Running post-action listener: _resource_record_post_action 12:47:04 INFO - ##### 12:47:04 INFO - ##### Running run-tests step. 12:47:04 INFO - ##### 12:47:04 INFO - Running pre-action listener: _resource_record_pre_action 12:47:04 INFO - Running main action method: run_tests 12:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:47:04 INFO - Python 2.7.3 12:47:04 INFO - Return code: 0 12:47:04 INFO - grabbing minidump binary from tooltool 12:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:47:04 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 0x2384410>, '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 0x2385310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:47:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:47:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:47:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:47:04 INFO - Return code: 0 12:47:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:47:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:47:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:47:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:47:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:47:05 INFO - Return code: 0 12:47:05 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/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 12:47:05 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/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 12:47:05 INFO - Using env: {'DISPLAY': ':0', 12:47:05 INFO - 'HOME': '/home/cltbld', 12:47:05 INFO - 'LANG': 'en_US.UTF-8', 12:47:05 INFO - 'LANGUAGE': 'en_US:en', 12:47:05 INFO - 'LOGNAME': 'cltbld', 12:47:05 INFO - 'MAIL': '/var/mail/cltbld', 12:47:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:47:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:47:05 INFO - 'MOZ_NO_REMOTE': '1', 12:47:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:47:05 INFO - 'NO_EM_RESTART': '1', 12:47:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:47:05 INFO - 'PWD': '/builds/slave/test', 12:47:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:47:05 INFO - 'SHELL': '/bin/bash', 12:47:05 INFO - 'SHLVL': '1', 12:47:05 INFO - 'TERM': 'linux', 12:47:05 INFO - 'TMOUT': '86400', 12:47:05 INFO - 'USER': 'cltbld', 12:47:05 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696', 12:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:47:05 INFO - '_': '/tools/buildbot/bin/python'} 12:47:05 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/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 12:47:05 INFO - mozversion application_buildid: 20160411115110 12:47:05 INFO - mozversion application_changeset: 88a5069742fee445e11923ad865f8a9bf88a25eb 12:47:05 INFO - mozversion application_display_name: Nightly 12:47:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:47:05 INFO - mozversion application_name: Firefox 12:47:05 INFO - mozversion application_remotingname: firefox 12:47:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:47:05 INFO - mozversion application_vendor: Mozilla 12:47:05 INFO - mozversion application_version: 48.0a1 12:47:05 INFO - mozversion platform_buildid: 20160411115110 12:47:05 INFO - mozversion platform_changeset: 88a5069742fee445e11923ad865f8a9bf88a25eb 12:47:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:47:05 INFO - mozversion platform_version: 48.0a1 12:47:05 INFO - using testdate: 1460404025 12:47:05 INFO - actual date: 1460404025 12:47:05 INFO - starting webserver on 'localhost:45442' 12:47:05 INFO - SUITE-START | Running 2 tests 12:47:05 INFO - TEST-START | dromaeo_css 12:47:05 INFO - operating with platform_type : linux_ 12:47:05 INFO - Initialising browser for dromaeo_css test... 12:47:05 INFO - TEST-INFO | started process 13179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzJMmsS/profile http://localhost:45442/getInfo.html) 12:47:09 INFO - PROCESS | 13179 | 12:47:09 INFO - PROCESS | 13179 | (process:13246): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:47:10 INFO - PROCESS | 13179 | 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] 12:47:10 INFO - PROCESS | 13179 | __metrics Screen width/height:1600/1200 12:47:10 INFO - PROCESS | 13179 | colorDepth:24 12:47:10 INFO - PROCESS | 13179 | Browser inner width/height: 1024/697 12:47:10 INFO - PROCESS | 13179 | __metrics 12:47:11 ERROR - PROCESS | 13179 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 12:47:12 INFO - TEST-INFO | 13179: exit 0 12:47:12 INFO - Browser initialized. 12:47:12 INFO - Running cycle 1/1 for dromaeo_css test... 12:47:12 INFO - TEST-INFO | started process 13297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzJMmsS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:47:14 INFO - PROCESS | 13297 | 12:47:14 INFO - PROCESS | 13297 | (process:13356): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:47:24 INFO - PROCESS | 13297 | RSS: Main: 164696064 12:47:24 INFO - PROCESS | 13297 | 12:48:14 INFO - PROCESS | 13297 | 1460404094063 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:50:26 INFO - PROCESS | 13297 | Cycle 1(1): loaded http://localhost:45442/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45442/tests/dromaeo/cssquery-ext.html) 12:50:27 INFO - PROCESS | 13297 | RSS: Main: 168914944 12:50:27 INFO - PROCESS | 13297 | 12:53:29 INFO - PROCESS | 13297 | Cycle 1(1): loaded http://localhost:45442/tests/dromaeo/cssquery-ext.html (next: http://localhost:45442/tests/dromaeo/cssquery-jquery.html) 12:53:29 INFO - PROCESS | 13297 | RSS: Main: 167706624 12:53:29 INFO - PROCESS | 13297 | 12:56:31 INFO - PROCESS | 13297 | Cycle 1(1): loaded http://localhost:45442/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45442/tests/dromaeo/cssquery-mootools.html) 12:56:32 INFO - PROCESS | 13297 | RSS: Main: 166506496 12:56:32 INFO - PROCESS | 13297 | 12:59:34 INFO - PROCESS | 13297 | Cycle 1(1): loaded http://localhost:45442/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45442/tests/dromaeo/cssquery-prototype.html) 12:59:34 INFO - PROCESS | 13297 | RSS: Main: 164392960 12:59:34 INFO - PROCESS | 13297 | 13:02:37 INFO - PROCESS | 13297 | Cycle 1(1): loaded http://localhost:45442/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45442/tests/dromaeo/cssquery-yui.html) 13:02:38 INFO - PROCESS | 13297 | RSS: Main: 165904384 13:02:38 INFO - PROCESS | 13297 | 13:05:40 INFO - PROCESS | 13297 | Cycle 1(1): loaded http://localhost:45442/tests/dromaeo/cssquery-yui.html (next: http://localhost:45442/tests/dromaeo/cssquery-dojo.html) 13:05:40 INFO - PROCESS | 13297 | RSS: Main: 168030208 13:05:40 INFO - PROCESS | 13297 | 13:05:40 INFO - PROCESS | 13297 | __start_tp_report 13:05:40 INFO - PROCESS | 13297 | _x_x_mozilla_page_load 13:05:40 INFO - PROCESS | 13297 | _x_x_mozilla_page_load_details 13:05:40 INFO - PROCESS | 13297 | |i|pagename|runs| 13:05:40 INFO - PROCESS | 13297 | |0;dojo.html;2662.334416395901;2708.9187324380264;2739.945201095978;2741.465414244222;2746.6429364182654;4816.590589799866;4820.855374338771;4846.442659094205;4866.197077482216;4929.556339929406;4724.716517008973;4788.952110478895;4799.520047995199;4810.470848206694;4812.278158276252;4359.651227901776;4389.012472193747;4467.061916997434;4560.247559152735;4561.498235194126;4458.308962110878;4512.887177820548;4514.097180563884;4528.637708983273;4547.886302842422;4418.64650827933;4453.755043472608;4473.038296766194;4485.215087359716;4487.214737420954;4329.177456283296;4457.821687132511;4476.507584165739;4502.189605870942;4502.4371953505815;4425.159219748238;4436.401085853433;4438.134563760068;4444.688871778977;4483.058557702886;4688.5545873142;4703.7883295251795;4733;4741.454732705749;4809.1824389853455;5138.049460849755;5139.974300128512;5146.845594632167;5163.586913046947;5163.845084647429;5214.165733482625;5221.660592061504;5226.05930932432;5240.371155461331;5268.025415298182;4696.577308042224;4851.539103785135;4856.927146092811;4869.756512174377;4910.975445122752;5228.2680424740565;5250.65870718402;5251.238570407346;5259.789608415621;5300.867478312995;5033.672811267256;5036.647434679538;5041.873953151127;5043.470435604282;5075.847724568269;5031.647784655039;5144.6655967362;5147.794088236504;5204.323437953042;5239.1093514102695;5154.896902061938;5169.948300517022;5174.663646862942;5174.793008279702;5179.611529135254;5146.202338637517;5149.871253218699;5161.225816127611;5170.844874653766;5197;4179.895502612399;4209.410682504452;4289.227938970953;4303.203907277164;4363.2800587903275;3730.515033045687;3752.8123593820746;3754.81225938702;3779.4519794629623;3785.413260944558;4512.323151527297;4534.841280555164;4538.636909047268;4548.385967894358;4561.635069194456;5082.669626474268;5189.506996835295;5238.73806309683;5245.921311180336;5297.443768404339;4524.47968483622;4529.886752831206;4537.069900670421;4577.793999270041;4588.334691469719;4490.910181796411;4646.372739680168;4651.906961860744;4654.418197725285;4701.694389864648;4893.09477746618;4930.506949305184;4930.852074437773;4981.203007518707;4984.077945580079;5102.4897510248675;5130.050940576006;5163.173892177234;5166.4058633257655;5219.660722053054;4807.278908163804;4864.708117512961;4889.731064791471;4892.9480759553635;4904.288878112725;5016;5045;5052.191649336089;5076.720780356968;5128.179491281527;5096.133657278346;5138.3577052868395;5147.382314122329;5156.716380599103;5192.9740351298005;4890.584300334512;4993.925091123709;5006.874828129326;5012.598992080698;5083.898322033465;5016.849494515171;5036.143855544493;5041.974790126173;5046.823361182341;5065.012322597058;4932.950670493249;4962.330085438564;4974.676646017997;4977.925331119964;4994.101061808909;4955.876103097307;5079.92380114306;5110.105731496898;5120.692758434506;5153.3558305211845;4779.426468823764;4882.584980276716;4933.210686290176;4938.358013458227;5014.598832093497 13:05:40 INFO - PROCESS | 13297 | |1;ext.html;564.5568228940283;600.9399060093991;620.8199622109591;620.8789286089211;639.577878600124;32267.51598726021;33237.83381083097;33289.500657490156;33303.16742081446;33363.16592085199;32853.67146328536;33388;33483.330333393315;33617.32765344692;33655.66344336562;7613.314801667862;7795.610219489003;7807.843843123134;7823.0612326520895;7827.491213071161;7663.846723065535;7740.8838867417035;7745.65144568493;7795.181505941851;7811.921880781205;7754.689812407497;7806.180351063142;7827.491213071161;7829.804254893645;7847.960760196191;7722.111957124918;7740.458167928219;7756;7765.262300081511;7784.766457006299;7744.535327880345;7796.947412099351;7827.491213071132;7827.921720782776;7866.331361834251;29095.41809163805;35262;35352.292954141034;36009;36245;2924.956125658117;3029.1366960416176;3048.405560915622;3223.7421006319437;3630.6913912317486;24017.639735403984;24143.792810359413;24204.87897560501;24892;24979.375515612253;3341.816200108993;3449.6032956209856;3525.347810655037;3614.7650402724003;3628.51015112959;161982;163123;163980;164509.9999999988;164609;32245.35509289848;46057.848553786425;47130.29304560435;47171.29243061357;47202;31385.215369615486;31507.684923150933;31620.683793161774;31700.841495792374;31733.20666983344;12480.563180288646;12560;12712.872871271355;12747.49010039588;12757.744845103232;10334.948325258325;10369.740756480998;10401.84397234042;10444;10473.895261047444;7944.205579442125;8067.273945344947;8112.18878112184;8186.918130818615;8235.670573177125;3158.8894388696285;3162.3517178978254;3184.060702092842;3188.457962146441;3211.5022171563446;849.4223927729204;858.9012263589642;890.4078787606298;891.31814162166;904.7692838326317;28486.572701409495;28500.572491412644;28551.143465696063;28634.713652863622;28646.427071458453;975;977.4623956823718;988.7478692933399;998.3810037776625;1109.7003808971533;14869.18219497938;15224.238788060775;15225.467108651144;15226.847731522765;15521.146336951577;310510;316878;318554;319096;319669;45868;46085.7695711526;46397.536024639325;46799.42603156791;48713;1197.1560050164612;1232.5316379775807;1239.510393394604;1256.2525297448003;1271.4024408527978;24652.630210547213;26134.607980879922;26171.869140654177;26486.602700959116;27268.181954541396;42057.78971105125;42119.15761684688;42253.36619950642;42572.5742742581;42763.78618106889;270816;276389;276476;276601;276777;25013.874930625232;25117.98584169838;25214.621780672936;25432.872835635702;25437;41979.37030944599;42107;42147.1570568593;42512.574874252095;42537;34775.65224347724;35510.82244588761;36044;36216.81891590525;37050.07374815543;35773.46339804957;36033.639663603026;36476;36804.447933280484;37064.81467592645;35867.461988070725;36097.27805443929;36250.456243155844;36309.27381452303;37071.44392834056;31937;32192.35615287728;32545.00984784242;32558.02325930226;32835.34329313353;25247.74752252454;25405.872970635028;25676.61485077688;25737.742622573536;25968.8701556491 13:05:40 INFO - PROCESS | 13297 | |2;jquery.html;365.4937910993275;371.41131306878594;373.7719990805608;376.7607569193562;381.31934496923;15078;15273.159976201305;15722.292496837656;15754.606134846634;15809.525714228592;15452.84547154528;16463.094529800885;16507.33970641173;16565.337386504525;16569.585760355996;4878.414590249157;5135.486451354872;5162.457941916101;5168.689878607295;5171.948280517203;3670.4127339625666;5058.190689489682;5507.834764957058;5829.242198514187;5845.415458454142;5771.740271687784;5778.508826749731;5798.159266906296;5799.623024503415;5800.129980502916;5613.017721898672;5973.163757074013;5980.73086711099;5987.790427335022;6010.368911264298;4519.615832654228;5234.057869583474;5240.161574148118;5241.397239317489;5263.31576895005;11781.882181178164;12017.93991030048;12127.332996685178;12131.454084566216;12153.088518361159;1772.3782738793989;1846.3567424991768;1904.7142928560688;1921.6541022615922;1983.5041239690077;8968.596413161424;9018;9131.086891310815;9139.360244782867;9173.81652366949;1742.8082910879793;1743.2678275124479;1753.9649207015916;1817.0823734014239;1820.7724034495689;66538;68110.65944670246;68602.3139768601;68915.31084689139;69252.3074769251;9562.426254424758;9742.95128524353;9902.702918912444;10052.941764059477;10170.135538479164;13909.860901390857;13950.581482555539;13953.813925816215;14014.089084209698;14020.85979140216;6737.225219099866;6827.52207345481;6876.209235937931;6885.345892140239;6991.545549539263;6189.566730328834;6202.41077097675;6233.750649974041;6297.983341073203;6416.262129855033;4083.244599749056;4273.059926816096;4308.095299986975;4314.576189857402;4421.823127074946;1644.7039532883957;1709.3675340123984;1838.7241913712783;1902.1915685833465;1919.280269898788;840.7561807076002;843.2705709561185;868.9913100869037;995.8804943406838;1020.9438480883623;15290.694186116216;15970.840291596935;16000.679986400206;16004.119773412342;16074.517764467084;851.4720873058743;853.5220276645099;865.1651156633752;874.4141425245101;975.5805003848271;8917.375783695079;8959.372843900865;9027.909720902839;9106.453612783254;9284;362343;363396;376132;385095;388520;61544.07683884745;72820.2717972824;73011.26988730044;76495;78544;941.463365881441;947.2942657720042;948.83869742144;951.1249650321721;972.7130496503548;14201.502947396792;14434.711305773615;14474.203918784147;14487.565373038826;14494.782578261545;31314;32378.35243295168;32507.18732031718;33115.17212069718;33483.33033339271;45888.77055614834;46618.06763864771;46697.53302466932;46780.29829552492;46808.53191468042;5421;7288.380487658396;7372.631368431665;7525.661345239368;7779.844403111792;9052.592633331647;11177.832332514856;11339.206255562032;11503.217001364801;11585.246958947642;9647.228221742103;9716.222702183666;10177.542010609392;10199.7450063749;10231.386116833013;9654.75863103428;9892.258080644124;9931.304808663614;10040.69877903664;10132.696019119438;9320.95339523298;9724.367916085432;9906.405615663083;10109.545070471699;10182.541785619516;6667.499937504804;7071.71713131469;7171.964140179266;7288.234735352712;7725.884111738216;7847.9215207849475;9696.660616878375;10127.291089623655;10202.591896324064;10379.06588407047 13:05:40 INFO - PROCESS | 13297 | |3;mootools.html;1430.1919415530228;1463.7511623024084;1580.4231455518732;1752.7458518514823;1778.208697129777;6940.826479338019;7533.510321829077;7540.472166948316;7753.496022758523;7792.649330780121;7522.8119297017465;7576.280253375934;7632.084149902005;7636.732714354998;7650.846983060335;2240.11515451397;2249.3701763506165;2259.378670865509;2260.8191344692386;2281.0191617604423;2207.746109197447;2221.9333419997424;2247.78646028627;2252.526969336433;2261.412032871449;2212.7565967743535;2236.105557776886;2236.6197746383154;2280.783325584067;2295.276987748862;2206.6028114939304;2207.7129973103556;2213.756486786452;2218.4453886528368;2227.365200917731;2202.5815095131875;2207.315732123047;2207.746109197447;2211.1045026764186;2215.069670738294;7637.541747495113;7741.651625676802;7768.378529717609;7778.299953004257;7800.4149688773;4610.9308360374625;4707.8587642370785;4734.905301893943;4739.644526660514;4740.360051393087;2867.6702179249446;2873.540233562641;2897.5798509216047;2899.9275018124504;2906.564015397686;954.5513608603945;986.9309148359546;990.1138481059412;1000;1029.7013865978856;10307.484625768682;10315.690529284133;10364.896351036468;10369.274150809446;10442.582296708122;4157.584241575818;4209.5579964103945;4391.516933137353;4402.669799765031;4423.203823311835;8947.32895032875;9041.90958090424;9049.864252036225;9052.954735226282;9059.909400905906;4748;4755.2153894607;4762.095201911626;4764.618830493552;4771.594414474739;3658.323210206067;4158.896027599334;4287.6998610097;4356.019895523482;4363;3619.1856832213066;3663.8351274192723;3706.2402207547925;3717.386631205875;3743.1952130292116;1194.8685644579089;1202.290648517379;1207.9758404831855;1229.9385030748426;1232.0820988363726;1039.9948000259951;1057.6351158850184;1059.7244716373798;1132.7224829916722;1221.3770976801895;7302.963485182647;7309.634518274172;7333.559986400833;7335.963320183471;7392.630368481555;413.5512968429228;415.5532802237546;418.56887405971895;420.46600816962285;423.2297219061279;5447;5501.229827824108;5655.971720141373;5667.206591077253;5670.688112153789;9126.996030436647;9363.765905852408;9538.52307384628;9560.091791279818;9572.56923438447;9329.626814927462;9384.577694003787;9387.10822471864;9420.152186303265;9450.905490945002;7230.6384680766805;7237.384822290164;7315.597642129734;7350.375218106414;7384.446166537531;7045.11936007999;7158.749443769443;7172.892406614009;7181.281871812777;7190;8742.694005709769;8788.384813063025;8835.249003834746;8876.467411955304;8994.865077023718;8744.994325652377;8806.647734090564;8826.646934122564;8874.511901845202;8926.196642302224;5835.85654185533;6701.899471508029;6742.157230346207;6845.623490708059;6924.065251191025;7271.8909216360735;7310.561366318038;7320.487565870338;7334.559926404433;7368.189499154982;6630.9336906630315;6973.3375329343635;6993.055937448379;7015.333543313377;7092.574445533284;6887.827804304932;6964.860702786017;6965.6168910708375;7052.047973523714;7059.223485416703;7169.533980291264;7249.383802376857;7278.944553039673;7291.635418229173;7323.377512911462;6024.8795024100145;6033.487153591818;6066.636001839904;6090.573659843769;6156.569040167145;6419.935800642121;6637.137172167587;6720.294369091371;6722.193336799615;6769.458443324621 13:05:40 INFO - PROCESS | 13297 | |4;prototype.html;305.3054301464169;309.9752019838413;313.19821257580594;314.1392584318964;319.4633016532228;5335.306410166678;5351.839444816657;5428.972855135728;5438.368489453158;5459.481349271813;5333.4399888011785;5348.572114230862;5358.3569971603365;5368.1679339702405;5368.382635996862;3946.2896678597913;4023.577524359944;4179.602937720927;4183.560726123759;4186.141840922619;4170.70805043647;4177.979110104445;4180.101278225181;4182.769947652878;4184.6984158712585;4116.75299482032;4159.292920203573;4169.3954376615375;4174.394712766647;4177.916441671165;4080.36754303085;4147.751134931884;4172.7496350218935;4173.24881521326;4178.991126388995;3639.4540818877117;3648.4709717091137;3654.104744337628;3657.140571965586;3662.8278950735776;5094.4141423736;5102.948970510284;5107.821226257063;5124.026434977342;5124.461931497176;4680.508546602592;4696.7651617419;4739.502352253033;4765.261384485376;4794.832180873653;5575.69333686647;5578.330600327987;5582.134769110794;5582.190582365575;5612.765191657829;4001.5998400160042;4006.078601921545;4006.2988976928923;4010.5387880393837;4021.2359651666384;5777.133429985493;5879.647221166701;5913.02435098204;5923.437273459014;5934.821955341346;4112.670986321147;4135.97932010338;4144.33690609501;4146.336586146263;4148.211839750437;4155.605217504332;4165.854195103157;4174.519930208005;4202.978985105055;4206.284931561642;4424;4712.835050773207;4717.740524271129;4756.7145971241835;4764.523547645277;5615.831525054255;5621.4378562144275;5637.9718101409235;5642.576806739511;5646.85882852932;1389.8818600419077;1397.8672026157499;1413.9787903181254;1420.843707192208;1422;881.4843316659826;911.8768966189613;926.1664501948301;929.0802105915095;931.5575101826713;4934.629902757308;4939.802407903716;4946.455889852114;4952.380952380952;4959.231319145538;5704.3154821421695;5722.2561067061015;5741.770329186869;5748.310202775694;5772.826815195551;4742.312364707167;4922;4934.432540257844;4935.358403407534;5056.544910957958;3089.644690860535;3095.5511450839504;3116.8000319876555;3130.201798541357;3139.937201255962;5475.09660905946;5482.998705472473;5493.835184944458;5498.1752737089755;5507.449255074461;5852.092925596454;5969.522438204933;6041.24484439445;6061.060535616986;6063.363346848606;5519.227308176858;5533.142362933751;5538.280023596906;5542.140968149944;5547.084731019418;5664.0654292043;5852.326982397079;5853.970730146322;5860.443257890493;5900.321463031806;5652.463016013472;5658.660480371191;5670.546356291405;5702.714864256854;5743.59794814359;5470.72646367688;5480.808171713971;5481.972590137024;5497.76300332422;5499.312585926759;3874.593167717349;3909.0813658789593;3913.7104793696008;3934.468846705658;3950.9407358890217;5837.474627283565;5854.590178687621;5889.087191485327;5893.292804863444;5896.469317761422;5579.015226853614;5671.914921276267;5687.530606330218;5696.373398926197;5705.914411283751;5395.947790180877;5584.776608935597;5618.6628802272;5632.690202038763;5641.8589535261945;5275.182346736262;5511.807086752105;5536.972315138399;5554.111342185231;5573.944260557342;5459.235707000944;5587.519307383628;5665.093585026376;5671.461211184931;5686.061799803151;5541.445855414427;5542.916856247079;5553.694546799965;5561.221429000024;5561.360443549043 13:05:40 INFO - PROCESS | 13297 | |5;yui.html;661.3617858766289;704.8836941904584;768.488954845028;777.9222077792222;783.8667426537488;12317;12374.752504949896;12477.812832807514;12502;12644.747105057893;11703.239289446201;11968.102392320567;12016.158868879182;12068.517259309618;12103.21329113607;640.7084776426738;783.3928705253417;791.7268542352908;805.7018903005896;815.4454970620005;798.808286011356;799.0451410564378;800.6757263308369;806.0609390060572;807.2331285278979;835.5070508400042;839.492107275099;842.3093063687778;844.3962566764762;846.4032856835915;828.1263267253046;830.2154464031493;833.5957060825494;837.5435387713711;837.7989282572199;626.2422468812742;628.4469666693326;630.593267342566;631.3497097989078;631.962082275065;12243.69390765229;12324;12333.753324933452;12354.0734444917;12355.938220308932;12735.490580376774;12819.359032048453;12837.358132093357;12909.741805163938;13133.212007279499;9759.316847820655;9842.65550705729;10209.183265338756;10266.7433314167;10268.48657567126;3365.2764655598917;3428.674275943806;3454.602720687103;3525.7355698322726;3543.8228088595465;44931.550684493064;45153.774231128635;45240.09519809618;45879;45896.770516147204;10110.848337274947;10134.797304053878;10193;10262.281640285108;10436.686899393031;17694.469165925042;17841.821581784017;17887.37394191197;17905;18032.549186270448;6732.966335168293;6767.830804229934;6810.148731408574;6945.374916257561;6955.374016338453;3713.925721485555;3769.5288088988877;3803.980980095137;3904.590018048121;3939.3106206413763;2727.699953005168;2809.2415047936943;2814.3667674773014;2814.6340975673033;2817.9718202817708;486.82230985690677;502.2892606961182;508.63378367575285;511.0775051032847;512.4132867866272;602.4307029856831;635.3995474276857;645.9450946669585;657.8914479110989;677.5291172634971;7822.256885595859;8119.4722343047515;8290.792730181673;8442.915570844212;8614.827703445895;598.1038624657617;670.128832517725;670.3062330488019;672.5863593889723;684.2199892122984;3849.74976626524;4005.118873847749;4049.453323801249;4054.8986275342763;4084.65280451159;48074.759626201645;48178;48503;48690.75654621704;48814;42901;43798.56201437945;43954;43968.56031439709;44937.10125797466;39735;40347.394789078186;40514.79742601268;41114;41481.792591037454;7611.540719951371;7708.344790692854;7709.498882572615;7747.767566973;7869.527828330319;27789.305267368476;28567.857160714062;28845;28942.565861511674;29086.127416177547;33723.3255334887;34609.65390346165;36460.27079458449;36490.63509364872;36734.44898326474;9452.669156579486;9567.138957493858;9711.36876103051;9762.853557196506;9818.214542836698;10198.847017294598;10267.486625668538;10267.486625668538;10530.21023423231;10671.679849604525;9321.673741419017;9713.805723885624;9941.602335906482;9974.251931105342;10227.232957528364;9932.25508086882;9971.351862128939;10323.793524129625;10332.276740628084;10721.731956700833;9908.455034973145;9918.448533068125;9998.800023999334;10266.794664106825;10406.58373665045;8034.211862634894;8054.476459030145;8311.501309921425;8425.747227583182;8639.654413823377;8350.373721970755;8728.869066963875;8778.561071946506;8782.341324400822;8886.641783276691 13:05:40 INFO - PROCESS | 13297 | __end_tp_report 13:05:40 INFO - PROCESS | 13297 | __start_cc_report 13:05:40 INFO - PROCESS | 13297 | _x_x_mozilla_cycle_collect,386 13:05:40 INFO - PROCESS | 13297 | __end_cc_report 13:05:40 INFO - PROCESS | 13297 | __startTimestamp1460405140609__endTimestamp 13:05:40 INFO - PROCESS | 13297 | 13:05:40 INFO - PROCESS | 13297 | ------- Summary: start ------- 13:05:40 INFO - PROCESS | 13297 | Number of tests: 6 13:05:40 INFO - PROCESS | 13297 | 13:05:40 INFO - PROCESS | 13297 | [#0] dojo.html Cycles:165 Average:4775.74 Median:4910.98 stddev:498.93 (10.2%) stddev-sans-first:472.12 13:05:40 INFO - PROCESS | 13297 | Values: 2662.3 2708.9 2739.9 2741.5 2746.6 4816.6 4820.9 4846.4 4866.2 4929.6 4724.7 4789.0 4799.5 4810.5 4812.3 4359.7 4389.0 4467.1 4560.2 4561.5 4458.3 4512.9 4514.1 4528.6 4547.9 4418.6 4453.8 4473.0 4485.2 4487.2 4329.2 4457.8 4476.5 4502.2 4502.4 4425.2 4436.4 4438.1 4444.7 4483.1 4688.6 4703.8 4733.0 4741.5 4809.2 5138.0 5140.0 5146.8 5163.6 5163.8 5214.2 5221.7 5226.1 5240.4 5268.0 4696.6 4851.5 4856.9 4869.8 4911.0 5228.3 5250.7 5251.2 5259.8 5300.9 5033.7 5036.6 5041.9 5043.5 5075.8 5031.6 5144.7 5147.8 5204.3 5239.1 5154.9 5169.9 5174.7 5174.8 5179.6 5146.2 5149.9 5161.2 5170.8 5197.0 4179.9 4209.4 4289.2 4303.2 4363.3 3730.5 3752.8 3754.8 3779.5 3785.4 4512.3 4534.8 4538.6 4548.4 4561.6 5082.7 5189.5 5238.7 5245.9 5297.4 4524.5 4529.9 4537.1 4577.8 4588.3 4490.9 4646.4 4651.9 4654.4 4701.7 4893.1 4930.5 4930.9 4981.2 4984.1 5102.5 5130.1 5163.2 5166.4 5219.7 4807.3 4864.7 4889.7 4892.9 4904.3 5016.0 5045.0 5052.2 5076.7 5128.2 5096.1 5138.4 5147.4 5156.7 5193.0 4890.6 4993.9 5006.9 5012.6 5083.9 5016.8 5036.1 5042.0 5046.8 5065.0 4933.0 4962.3 4974.7 4977.9 4994.1 4955.9 5079.9 5110.1 5120.7 5153.4 4779.4 4882.6 4933.2 4938.4 5014.6 13:05:40 INFO - PROCESS | 13297 | 13:05:40 INFO - PROCESS | 13297 | [#1] ext.html Cycles:180 Average:39827.37 Median:33550.33 stddev:68383.84 (203.8%) stddev-sans-first:68512.14 13:05:40 INFO - PROCESS | 13297 | Values: 564.6 600.9 620.8 620.9 639.6 32267.5 33237.8 33289.5 33303.2 33363.2 32853.7 33388.0 33483.3 33617.3 33655.7 7613.3 7795.6 7807.8 7823.1 7827.5 7663.8 7740.9 7745.7 7795.2 7811.9 7754.7 7806.2 7827.5 7829.8 7848.0 7722.1 7740.5 7756.0 7765.3 7784.8 7744.5 7796.9 7827.5 7827.9 7866.3 29095.4 35262.0 35352.3 36009.0 36245.0 2925.0 3029.1 3048.4 3223.7 3630.7 24017.6 24143.8 24204.9 24892.0 24979.4 3341.8 3449.6 3525.3 3614.8 3628.5 161982.0 163123.0 163980.0 164510.0 164609.0 32245.4 46057.8 47130.3 47171.3 47202.0 31385.2 31507.7 31620.7 31700.8 31733.2 12480.6 12560.0 12712.9 12747.5 12757.7 10334.9 10369.7 10401.8 10444.0 10473.9 7944.2 8067.3 8112.2 8186.9 8235.7 3158.9 3162.4 3184.1 3188.5 3211.5 849.4 858.9 890.4 891.3 904.8 28486.6 28500.6 28551.1 28634.7 28646.4 975.0 977.5 988.7 998.4 1109.7 14869.2 15224.2 15225.5 15226.8 15521.1 310510.0 316878.0 318554.0 319096.0 319669.0 45868.0 46085.8 46397.5 46799.4 48713.0 1197.2 1232.5 1239.5 1256.3 1271.4 24652.6 26134.6 26171.9 26486.6 27268.2 42057.8 42119.2 42253.4 42572.6 42763.8 270816.0 276389.0 276476.0 276601.0 276777.0 25013.9 25118.0 25214.6 25432.9 25437.0 41979.4 42107.0 42147.2 42512.6 42537.0 34775.7 35510.8 36044.0 36216.8 37050.1 35773.5 36033.6 36476.0 36804.4 37064.8 35867.5 36097.3 36250.5 36309.3 37071.4 31937.0 32192.4 32545.0 32558.0 32835.3 25247.7 25405.9 25676.6 25737.7 25968.9 13:05:40 INFO - PROCESS | 13297 | 13:05:40 INFO - PROCESS | 13297 | [#2] jquery.html Cycles:180 Average:23023.83 Median:5096.84 stddev:61942.27 (1215.3%) stddev-sans-first:62092.67 13:05:40 INFO - PROCESS | 13297 | Values: 365.5 371.4 373.8 376.8 381.3 15078.0 15273.2 15722.3 15754.6 15809.5 15452.8 16463.1 16507.3 16565.3 16569.6 4878.4 5135.5 5162.5 5168.7 5171.9 3670.4 5058.2 5507.8 5829.2 5845.4 5771.7 5778.5 5798.2 5799.6 5800.1 5613.0 5973.2 5980.7 5987.8 6010.4 4519.6 5234.1 5240.2 5241.4 5263.3 11781.9 12017.9 12127.3 12131.5 12153.1 1772.4 1846.4 1904.7 1921.7 1983.5 8968.6 9018.0 9131.1 9139.4 9173.8 1742.8 1743.3 1754.0 1817.1 1820.8 66538.0 68110.7 68602.3 68915.3 69252.3 9562.4 9743.0 9902.7 10052.9 10170.1 13909.9 13950.6 13953.8 14014.1 14020.9 6737.2 6827.5 6876.2 6885.3 6991.5 6189.6 6202.4 6233.8 6298.0 6416.3 4083.2 4273.1 4308.1 4314.6 4421.8 1644.7 1709.4 1838.7 1902.2 1919.3 840.8 843.3 869.0 995.9 1020.9 15290.7 15970.8 16000.7 16004.1 16074.5 851.5 853.5 865.2 874.4 975.6 8917.4 8959.4 9027.9 9106.5 9284.0 362343.0 363396.0 376132.0 385095.0 388520.0 61544.1 72820.3 73011.3 76495.0 78544.0 941.5 947.3 948.8 951.1 972.7 14201.5 14434.7 14474.2 14487.6 14494.8 31314.0 32378.4 32507.2 33115.2 33483.3 45888.8 46618.1 46697.5 46780.3 46808.5 5421.0 7288.4 7372.6 7525.7 7779.8 9052.6 11177.8 11339.2 11503.2 11585.2 9647.2 9716.2 10177.5 10199.7 10231.4 9654.8 9892.3 9931.3 10040.7 10132.7 9321.0 9724.4 9906.4 10109.5 10182.5 6667.5 7071.7 7172.0 7288.2 7725.9 7847.9 9696.7 10127.3 10202.6 10379.1 13:05:40 INFO - PROCESS | 13297 | 13:05:40 INFO - PROCESS | 13297 | [#3] mootools.html Cycles:180 Average:5417.07 Median:6078.60 stddev:2858.78 (47.0%) stddev-sans-first:2851.10 13:05:40 INFO - PROCESS | 13297 | Values: 1430.2 1463.8 1580.4 1752.7 1778.2 6940.8 7533.5 7540.5 7753.5 7792.6 7522.8 7576.3 7632.1 7636.7 7650.8 2240.1 2249.4 2259.4 2260.8 2281.0 2207.7 2221.9 2247.8 2252.5 2261.4 2212.8 2236.1 2236.6 2280.8 2295.3 2206.6 2207.7 2213.8 2218.4 2227.4 2202.6 2207.3 2207.7 2211.1 2215.1 7637.5 7741.7 7768.4 7778.3 7800.4 4610.9 4707.9 4734.9 4739.6 4740.4 2867.7 2873.5 2897.6 2899.9 2906.6 954.6 986.9 990.1 1000.0 1029.7 10307.5 10315.7 10364.9 10369.3 10442.6 4157.6 4209.6 4391.5 4402.7 4423.2 8947.3 9041.9 9049.9 9053.0 9059.9 4748.0 4755.2 4762.1 4764.6 4771.6 3658.3 4158.9 4287.7 4356.0 4363.0 3619.2 3663.8 3706.2 3717.4 3743.2 1194.9 1202.3 1208.0 1229.9 1232.1 1040.0 1057.6 1059.7 1132.7 1221.4 7303.0 7309.6 7333.6 7336.0 7392.6 413.6 415.6 418.6 420.5 423.2 5447.0 5501.2 5656.0 5667.2 5670.7 9127.0 9363.8 9538.5 9560.1 9572.6 9329.6 9384.6 9387.1 9420.2 9450.9 7230.6 7237.4 7315.6 7350.4 7384.4 7045.1 7158.7 7172.9 7181.3 7190.0 8742.7 8788.4 8835.2 8876.5 8994.9 8745.0 8806.6 8826.6 8874.5 8926.2 5835.9 6701.9 6742.2 6845.6 6924.1 7271.9 7310.6 7320.5 7334.6 7368.2 6630.9 6973.3 6993.1 7015.3 7092.6 6887.8 6964.9 6965.6 7052.0 7059.2 7169.5 7249.4 7278.9 7291.6 7323.4 6024.9 6033.5 6066.6 6090.6 6156.6 6419.9 6637.1 6720.3 6722.2 6769.5 13:05:40 INFO - PROCESS | 13297 | 13:05:40 INFO - PROCESS | 13297 | [#4] prototype.html Cycles:180 Average:4667.36 Median:5363.26 stddev:1372.52 (25.6%) stddev-sans-first:1336.75 13:05:40 INFO - PROCESS | 13297 | Values: 305.3 310.0 313.2 314.1 319.5 5335.3 5351.8 5429.0 5438.4 5459.5 5333.4 5348.6 5358.4 5368.2 5368.4 3946.3 4023.6 4179.6 4183.6 4186.1 4170.7 4178.0 4180.1 4182.8 4184.7 4116.8 4159.3 4169.4 4174.4 4177.9 4080.4 4147.8 4172.7 4173.2 4179.0 3639.5 3648.5 3654.1 3657.1 3662.8 5094.4 5102.9 5107.8 5124.0 5124.5 4680.5 4696.8 4739.5 4765.3 4794.8 5575.7 5578.3 5582.1 5582.2 5612.8 4001.6 4006.1 4006.3 4010.5 4021.2 5777.1 5879.6 5913.0 5923.4 5934.8 4112.7 4136.0 4144.3 4146.3 4148.2 4155.6 4165.9 4174.5 4203.0 4206.3 4424.0 4712.8 4717.7 4756.7 4764.5 5615.8 5621.4 5638.0 5642.6 5646.9 1389.9 1397.9 1414.0 1420.8 1422.0 881.5 911.9 926.2 929.1 931.6 4934.6 4939.8 4946.5 4952.4 4959.2 5704.3 5722.3 5741.8 5748.3 5772.8 4742.3 4922.0 4934.4 4935.4 5056.5 3089.6 3095.6 3116.8 3130.2 3139.9 5475.1 5483.0 5493.8 5498.2 5507.4 5852.1 5969.5 6041.2 6061.1 6063.4 5519.2 5533.1 5538.3 5542.1 5547.1 5664.1 5852.3 5854.0 5860.4 5900.3 5652.5 5658.7 5670.5 5702.7 5743.6 5470.7 5480.8 5482.0 5497.8 5499.3 3874.6 3909.1 3913.7 3934.5 3950.9 5837.5 5854.6 5889.1 5893.3 5896.5 5579.0 5671.9 5687.5 5696.4 5705.9 5395.9 5584.8 5618.7 5632.7 5641.9 5275.2 5511.8 5537.0 5554.1 5573.9 5459.2 5587.5 5665.1 5671.5 5686.1 5541.4 5542.9 5553.7 5561.2 5561.4 13:05:40 INFO - PROCESS | 13297 | 13:05:40 INFO - PROCESS | 13297 | [#5] yui.html Cycles:180 Average:12252.00 Median:48340.50 stddev:13679.86 (28.3%) stddev-sans-first:13690.54 13:05:40 INFO - PROCESS | 13297 | Values: 661.4 704.9 768.5 777.9 783.9 12317.0 12374.8 12477.8 12502.0 12644.7 11703.2 11968.1 12016.2 12068.5 12103.2 640.7 783.4 791.7 805.7 815.4 798.8 799.0 800.7 806.1 807.2 835.5 839.5 842.3 844.4 846.4 828.1 830.2 833.6 837.5 837.8 626.2 628.4 630.6 631.3 632.0 12243.7 12324.0 12333.8 12354.1 12355.9 12735.5 12819.4 12837.4 12909.7 13133.2 9759.3 9842.7 10209.2 10266.7 10268.5 3365.3 3428.7 3454.6 3525.7 3543.8 44931.6 45153.8 45240.1 45879.0 45896.8 10110.8 10134.8 10193.0 10262.3 10436.7 17694.5 17841.8 17887.4 17905.0 18032.5 6733.0 6767.8 6810.1 6945.4 6955.4 3713.9 3769.5 3804.0 3904.6 3939.3 2727.7 2809.2 2814.4 2814.6 2818.0 486.8 502.3 508.6 511.1 512.4 602.4 635.4 645.9 657.9 677.5 7822.3 8119.5 8290.8 8442.9 8614.8 598.1 670.1 670.3 672.6 684.2 3849.7 4005.1 4049.5 4054.9 4084.7 48074.8 48178.0 48503.0 48690.8 48814.0 42901.0 43798.6 43954.0 43968.6 44937.1 39735.0 40347.4 40514.8 41114.0 41481.8 7611.5 7708.3 7709.5 7747.8 7869.5 27789.3 28567.9 28845.0 28942.6 29086.1 33723.3 34609.7 36460.3 36490.6 36734.4 9452.7 9567.1 9711.4 9762.9 9818.2 10198.8 10267.5 10267.5 10530.2 10671.7 9321.7 9713.8 9941.6 9974.3 10227.2 9932.3 9971.4 10323.8 10332.3 10721.7 9908.5 9918.4 9998.8 10266.8 10406.6 8034.2 8054.5 8311.5 8425.7 8639.7 8350.4 8728.9 8778.6 8782.3 8886.6 13:05:40 INFO - PROCESS | 13297 | -------- Summary: end -------- 13:05:40 INFO - PROCESS | 13297 | 13:05:41 INFO - TEST-INFO | 13297: exit 0 13:05:41 INFO - TEST-OK | dromaeo_css | took 1115332ms 13:05:41 INFO - TEST-START | kraken 13:05:41 INFO - operating with platform_type : linux_ 13:05:41 INFO - Initialising browser for kraken test... 13:05:41 INFO - TEST-INFO | started process 13532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH34oXI/profile http://localhost:45442/getInfo.html) 13:05:45 INFO - PROCESS | 13532 | 13:05:45 INFO - PROCESS | 13532 | (process:13598): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:05:45 INFO - PROCESS | 13532 | 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] 13:05:46 INFO - PROCESS | 13532 | __metrics Screen width/height:1600/1200 13:05:46 INFO - PROCESS | 13532 | colorDepth:24 13:05:46 INFO - PROCESS | 13532 | Browser inner width/height: 1024/697 13:05:46 INFO - PROCESS | 13532 | __metrics 13:05:46 ERROR - PROCESS | 13532 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 13:05:47 INFO - TEST-INFO | 13532: exit 0 13:05:47 INFO - Browser initialized. 13:05:47 INFO - Running cycle 1/1 for kraken test... 13:05:47 INFO - TEST-INFO | started process 13649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH34oXI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:05:49 INFO - PROCESS | 13649 | 13:05:49 INFO - PROCESS | 13649 | (process:13709): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:05:59 INFO - PROCESS | 13649 | RSS: Main: 164237312 13:05:59 INFO - PROCESS | 13649 | 13:06:02 INFO - PROCESS | 13649 | Cycle 1(1): loaded http://localhost:45442/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45442/tests/kraken/driver.html?testName=audio-beat-detection) 13:06:03 INFO - PROCESS | 13649 | RSS: Main: 168943616 13:06:03 INFO - PROCESS | 13649 | 13:06:06 INFO - PROCESS | 13649 | Cycle 1(1): loaded http://localhost:45442/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45442/tests/kraken/driver.html?testName=audio-dft) 13:06:06 INFO - PROCESS | 13649 | RSS: Main: 172355584 13:06:06 INFO - PROCESS | 13649 | 13:06:09 INFO - PROCESS | 13649 | Cycle 1(1): loaded http://localhost:45442/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45442/tests/kraken/driver.html?testName=audio-fft) 13:06:10 INFO - PROCESS | 13649 | RSS: Main: 164679680 13:06:10 INFO - PROCESS | 13649 | 13:06:12 INFO - PROCESS | 13649 | Cycle 1(1): loaded http://localhost:45442/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45442/tests/kraken/driver.html?testName=audio-oscillator) 13:06:13 INFO - PROCESS | 13649 | RSS: Main: 164446208 13:06:13 INFO - PROCESS | 13649 | 13:06:15 INFO - PROCESS | 13649 | Cycle 1(1): loaded http://localhost:45442/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45442/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:06:15 INFO - PROCESS | 13649 | RSS: Main: 164909056 13:06:15 INFO - PROCESS | 13649 | 13:06:19 INFO - PROCESS | 13649 | Cycle 1(1): loaded http://localhost:45442/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45442/tests/kraken/driver.html?testName=imaging-darkroom) 13:06:19 INFO - PROCESS | 13649 | RSS: Main: 165101568 13:06:19 INFO - PROCESS | 13649 | 13:06:23 INFO - PROCESS | 13649 | Cycle 1(1): loaded http://localhost:45442/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45442/tests/kraken/driver.html?testName=imaging-desaturate) 13:06:23 INFO - PROCESS | 13649 | RSS: Main: 164556800 13:06:23 INFO - PROCESS | 13649 | 13:06:26 INFO - PROCESS | 13649 | Cycle 1(1): loaded http://localhost:45442/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45442/tests/kraken/driver.html?testName=json-parse-financial) 13:06:27 INFO - PROCESS | 13649 | RSS: Main: 165023744 13:06:27 INFO - PROCESS | 13649 | 13:06:29 INFO - PROCESS | 13649 | Cycle 1(1): loaded http://localhost:45442/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45442/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:06:29 INFO - PROCESS | 13649 | RSS: Main: 165388288 13:06:29 INFO - PROCESS | 13649 | 13:06:31 INFO - PROCESS | 13649 | Cycle 1(1): loaded http://localhost:45442/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45442/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:06:32 INFO - PROCESS | 13649 | RSS: Main: 165392384 13:06:32 INFO - PROCESS | 13649 | 13:06:34 INFO - PROCESS | 13649 | Cycle 1(1): loaded http://localhost:45442/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45442/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:06:35 INFO - PROCESS | 13649 | RSS: Main: 165781504 13:06:35 INFO - PROCESS | 13649 | 13:06:38 INFO - PROCESS | 13649 | Cycle 1(1): loaded http://localhost:45442/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45442/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:06:38 INFO - PROCESS | 13649 | RSS: Main: 166416384 13:06:38 INFO - PROCESS | 13649 | 13:06:41 INFO - PROCESS | 13649 | Cycle 1(1): loaded http://localhost:45442/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45442/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:06:42 INFO - PROCESS | 13649 | RSS: Main: 165724160 13:06:42 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | Cycle 1(1): loaded http://localhost:45442/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45442/tests/kraken/driver.html?testName=ai-astar) 13:06:44 INFO - PROCESS | 13649 | RSS: Main: 167223296 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | __start_tp_report 13:06:44 INFO - PROCESS | 13649 | _x_x_mozilla_page_load 13:06:44 INFO - PROCESS | 13649 | _x_x_mozilla_page_load_details 13:06:44 INFO - PROCESS | 13649 | |i|pagename|runs| 13:06:44 INFO - PROCESS | 13649 | |0;ai-astar;117;108;115;114;115;127;114;114;115;113 13:06:44 INFO - PROCESS | 13649 | |1;audio-beat-detection;165;134;161;176;138;156;167;143;189;135 13:06:44 INFO - PROCESS | 13649 | |2;audio-dft;163;163;163;165;169;164;164;164;170;164 13:06:44 INFO - PROCESS | 13649 | |3;audio-fft;74;78;74;149;75;74;75;74;150;76 13:06:44 INFO - PROCESS | 13649 | |4;audio-oscillator;97;94;148;95;95;94;147;95;93;149 13:06:44 INFO - PROCESS | 13649 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;118;118;118 13:06:44 INFO - PROCESS | 13649 | |6;imaging-darkroom;148;147;146;148;147;147;146;148;146;147 13:06:44 INFO - PROCESS | 13649 | |7;imaging-desaturate;96;96;96;96;96;96;97;95;96;96 13:06:44 INFO - PROCESS | 13649 | |8;json-parse-financial;69;65;66;67;68;66;66;78;68;63 13:06:44 INFO - PROCESS | 13649 | |9;json-stringify-tinderbox;64;64;64;65;65;64;65;64;64;65 13:06:44 INFO - PROCESS | 13649 | |10;stanford-crypto-aes;93;85;83;86;88;85;86;86;86;86 13:06:44 INFO - PROCESS | 13649 | |11;stanford-crypto-ccm;144;139;147;138;146;148;138;149;177;145 13:06:44 INFO - PROCESS | 13649 | |12;stanford-crypto-pbkdf2;180;170;173;181;180;171;175;171;173;177 13:06:44 INFO - PROCESS | 13649 | |13;stanford-crypto-sha256-iterative;71;73;72;73;77;72;75;74;73;75 13:06:44 INFO - PROCESS | 13649 | __end_tp_report 13:06:44 INFO - PROCESS | 13649 | __start_cc_report 13:06:44 INFO - PROCESS | 13649 | _x_x_mozilla_cycle_collect,916 13:06:44 INFO - PROCESS | 13649 | __end_cc_report 13:06:44 INFO - PROCESS | 13649 | __startTimestamp1460405204384__endTimestamp 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | ------- Summary: start ------- 13:06:44 INFO - PROCESS | 13649 | Number of tests: 14 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:4.76 (4.1%) stddev-sans-first:5.00 13:06:44 INFO - PROCESS | 13649 | Values: 117.0 108.0 115.0 114.0 115.0 127.0 114.0 114.0 115.0 113.0 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | [#1] audio-beat-detection Cycles:10 Average:156.40 Median:163.00 stddev:18.66 (11.4%) stddev-sans-first:19.53 13:06:44 INFO - PROCESS | 13649 | Values: 165.0 134.0 161.0 176.0 138.0 156.0 167.0 143.0 189.0 135.0 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:2.51 (1.5%) stddev-sans-first:2.57 13:06:44 INFO - PROCESS | 13649 | Values: 163.0 163.0 163.0 165.0 169.0 164.0 164.0 164.0 170.0 164.0 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | [#3] audio-fft Cycles:10 Average:89.90 Median:74.50 stddev:31.44 (42.2%) stddev-sans-first:32.81 13:06:44 INFO - PROCESS | 13649 | Values: 74.0 78.0 74.0 149.0 75.0 74.0 75.0 74.0 150.0 76.0 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:94.50 stddev:25.76 (27.3%) stddev-sans-first:26.85 13:06:44 INFO - PROCESS | 13649 | Values: 97.0 94.0 148.0 95.0 95.0 94.0 147.0 95.0 93.0 149.0 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 13:06:44 INFO - PROCESS | 13649 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 13:06:44 INFO - PROCESS | 13649 | Values: 148.0 147.0 146.0 148.0 147.0 147.0 146.0 148.0 146.0 147.0 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 13:06:44 INFO - PROCESS | 13649 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 95.0 96.0 96.0 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:67.50 stddev:4.03 (6.0%) stddev-sans-first:4.25 13:06:44 INFO - PROCESS | 13649 | Values: 69.0 65.0 66.0 67.0 68.0 66.0 66.0 78.0 68.0 63.0 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 13:06:44 INFO - PROCESS | 13649 | Values: 64.0 64.0 64.0 65.0 65.0 64.0 65.0 64.0 64.0 65.0 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:2.63 (3.1%) stddev-sans-first:1.32 13:06:44 INFO - PROCESS | 13649 | Values: 93.0 85.0 83.0 86.0 88.0 85.0 86.0 86.0 86.0 86.0 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:146.50 stddev:11.28 (7.7%) stddev-sans-first:11.91 13:06:44 INFO - PROCESS | 13649 | Values: 144.0 139.0 147.0 138.0 146.0 148.0 138.0 149.0 177.0 145.0 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:176.00 stddev:4.15 (2.4%) stddev-sans-first:4.00 13:06:44 INFO - PROCESS | 13649 | Values: 180.0 170.0 173.0 181.0 180.0 171.0 175.0 171.0 173.0 177.0 13:06:44 INFO - PROCESS | 13649 | 13:06:44 INFO - PROCESS | 13649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:73.50 stddev:1.78 (2.4%) stddev-sans-first:1.64 13:06:44 INFO - PROCESS | 13649 | Values: 71.0 73.0 72.0 73.0 77.0 72.0 75.0 74.0 73.0 75.0 13:06:44 INFO - PROCESS | 13649 | -------- Summary: end -------- 13:06:44 INFO - PROCESS | 13649 | 13:06:45 INFO - TEST-INFO | 13649: exit 0 13:06:45 INFO - TEST-OK | kraken | took 64198ms 13:06:45 INFO - SUITE-END | took 1179s 13:06:45 INFO - Completed test suite (00:19:39) 13:06:45 INFO - javascript benchmark 13:06:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2662.334416395901, 2708.9187324380264, 2739.945201095978, 2741.465414244222, 2746.6429364182654, 4816.590589799866, 4820.855374338771, 4846.442659094205, 4866.197077482216, 4929.556339929406, 4724.716517008973, 4788.952110478895, 4799.520047995199, 4810.470848206694, 4812.278158276252, 4359.651227901776, 4389.012472193747, 4467.061916997434, 4560.247559152735, 4561.498235194126, 4458.308962110878, 4512.887177820548, 4514.097180563884, 4528.637708983273, 4547.886302842422, 4418.64650827933, 4453.755043472608, 4473.038296766194, 4485.215087359716, 4487.214737420954, 4329.177456283296, 4457.821687132511, 4476.507584165739, 4502.189605870942, 4502.4371953505815, 4425.159219748238, 4436.401085853433, 4438.134563760068, 4444.688871778977, 4483.058557702886, 4688.5545873142, 4703.7883295251795, 4733.0, 4741.454732705749, 4809.1824389853455, 5138.049460849755, 5139.974300128512, 5146.845594632167, 5163.586913046947, 5163.845084647429, 5214.165733482625, 5221.660592061504, 5226.05930932432, 5240.371155461331, 5268.025415298182, 4696.577308042224, 4851.539103785135, 4856.927146092811, 4869.756512174377, 4910.975445122752, 5228.2680424740565, 5250.65870718402, 5251.238570407346, 5259.789608415621, 5300.867478312995, 5033.672811267256, 5036.647434679538, 5041.873953151127, 5043.470435604282, 5075.847724568269, 5031.647784655039, 5144.6655967362, 5147.794088236504, 5204.323437953042, 5239.1093514102695, 5154.896902061938, 5169.948300517022, 5174.663646862942, 5174.793008279702, 5179.611529135254, 5146.202338637517, 5149.871253218699, 5161.225816127611, 5170.844874653766, 5197.0, 4179.895502612399, 4209.410682504452, 4289.227938970953, 4303.203907277164, 4363.2800587903275, 3730.515033045687, 3752.8123593820746, 3754.81225938702, 3779.4519794629623, 3785.413260944558, 4512.323151527297, 4534.841280555164, 4538.636909047268, 4548.385967894358, 4561.635069194456, 5082.669626474268, 5189.506996835295, 5238.73806309683, 5245.921311180336, 5297.443768404339, 4524.47968483622, 4529.886752831206, 4537.069900670421, 4577.793999270041, 4588.334691469719, 4490.910181796411, 4646.372739680168, 4651.906961860744, 4654.418197725285, 4701.694389864648, 4893.09477746618, 4930.506949305184, 4930.852074437773, 4981.203007518707, 4984.077945580079, 5102.4897510248675, 5130.050940576006, 5163.173892177234, 5166.4058633257655, 5219.660722053054, 4807.278908163804, 4864.708117512961, 4889.731064791471, 4892.9480759553635, 4904.288878112725, 5016.0, 5045.0, 5052.191649336089, 5076.720780356968, 5128.179491281527, 5096.133657278346, 5138.3577052868395, 5147.382314122329, 5156.716380599103, 5192.9740351298005, 4890.584300334512, 4993.925091123709, 5006.874828129326, 5012.598992080698, 5083.898322033465, 5016.849494515171, 5036.143855544493, 5041.974790126173, 5046.823361182341, 5065.012322597058, 4932.950670493249, 4962.330085438564, 4974.676646017997, 4977.925331119964, 4994.101061808909, 4955.876103097307, 5079.92380114306, 5110.105731496898, 5120.692758434506, 5153.3558305211845, 4779.426468823764, 4882.584980276716, 4933.210686290176, 4938.358013458227, 5014.598832093497], "value": 4744.014629762663, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.5568228940283, 600.9399060093991, 620.8199622109591, 620.8789286089211, 639.577878600124, 32267.51598726021, 33237.83381083097, 33289.500657490156, 33303.16742081446, 33363.16592085199, 32853.67146328536, 33388.0, 33483.330333393315, 33617.32765344692, 33655.66344336562, 7613.314801667862, 7795.610219489003, 7807.843843123134, 7823.0612326520895, 7827.491213071161, 7663.846723065535, 7740.8838867417035, 7745.65144568493, 7795.181505941851, 7811.921880781205, 7754.689812407497, 7806.180351063142, 7827.491213071161, 7829.804254893645, 7847.960760196191, 7722.111957124918, 7740.458167928219, 7756.0, 7765.262300081511, 7784.766457006299, 7744.535327880345, 7796.947412099351, 7827.491213071132, 7827.921720782776, 7866.331361834251, 29095.41809163805, 35262.0, 35352.292954141034, 36009.0, 36245.0, 2924.956125658117, 3029.1366960416176, 3048.405560915622, 3223.7421006319437, 3630.6913912317486, 24017.639735403984, 24143.792810359413, 24204.87897560501, 24892.0, 24979.375515612253, 3341.816200108993, 3449.6032956209856, 3525.347810655037, 3614.7650402724003, 3628.51015112959, 161982.0, 163123.0, 163980.0, 164509.9999999988, 164609.0, 32245.35509289848, 46057.848553786425, 47130.29304560435, 47171.29243061357, 47202.0, 31385.215369615486, 31507.684923150933, 31620.683793161774, 31700.841495792374, 31733.20666983344, 12480.563180288646, 12560.0, 12712.872871271355, 12747.49010039588, 12757.744845103232, 10334.948325258325, 10369.740756480998, 10401.84397234042, 10444.0, 10473.895261047444, 7944.205579442125, 8067.273945344947, 8112.18878112184, 8186.918130818615, 8235.670573177125, 3158.8894388696285, 3162.3517178978254, 3184.060702092842, 3188.457962146441, 3211.5022171563446, 849.4223927729204, 858.9012263589642, 890.4078787606298, 891.31814162166, 904.7692838326317, 28486.572701409495, 28500.572491412644, 28551.143465696063, 28634.713652863622, 28646.427071458453, 975.0, 977.4623956823718, 988.7478692933399, 998.3810037776625, 1109.7003808971533, 14869.18219497938, 15224.238788060775, 15225.467108651144, 15226.847731522765, 15521.146336951577, 310510.0, 316878.0, 318554.0, 319096.0, 319669.0, 45868.0, 46085.7695711526, 46397.536024639325, 46799.42603156791, 48713.0, 1197.1560050164612, 1232.5316379775807, 1239.510393394604, 1256.2525297448003, 1271.4024408527978, 24652.630210547213, 26134.607980879922, 26171.869140654177, 26486.602700959116, 27268.181954541396, 42057.78971105125, 42119.15761684688, 42253.36619950642, 42572.5742742581, 42763.78618106889, 270816.0, 276389.0, 276476.0, 276601.0, 276777.0, 25013.874930625232, 25117.98584169838, 25214.621780672936, 25432.872835635702, 25437.0, 41979.37030944599, 42107.0, 42147.1570568593, 42512.574874252095, 42537.0, 34775.65224347724, 35510.82244588761, 36044.0, 36216.81891590525, 37050.07374815543, 35773.46339804957, 36033.639663603026, 36476.0, 36804.447933280484, 37064.81467592645, 35867.461988070725, 36097.27805443929, 36250.456243155844, 36309.27381452303, 37071.44392834056, 31937.0, 32192.35615287728, 32545.00984784242, 32558.02325930226, 32835.34329313353, 25247.74752252454, 25405.872970635028, 25676.61485077688, 25737.742622573536, 25968.8701556491], "value": 15751.126607106182, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.4937910993275, 371.41131306878594, 373.7719990805608, 376.7607569193562, 381.31934496923, 15078.0, 15273.159976201305, 15722.292496837656, 15754.606134846634, 15809.525714228592, 15452.84547154528, 16463.094529800885, 16507.33970641173, 16565.337386504525, 16569.585760355996, 4878.414590249157, 5135.486451354872, 5162.457941916101, 5168.689878607295, 5171.948280517203, 3670.4127339625666, 5058.190689489682, 5507.834764957058, 5829.242198514187, 5845.415458454142, 5771.740271687784, 5778.508826749731, 5798.159266906296, 5799.623024503415, 5800.129980502916, 5613.017721898672, 5973.163757074013, 5980.73086711099, 5987.790427335022, 6010.368911264298, 4519.615832654228, 5234.057869583474, 5240.161574148118, 5241.397239317489, 5263.31576895005, 11781.882181178164, 12017.93991030048, 12127.332996685178, 12131.454084566216, 12153.088518361159, 1772.3782738793989, 1846.3567424991768, 1904.7142928560688, 1921.6541022615922, 1983.5041239690077, 8968.596413161424, 9018.0, 9131.086891310815, 9139.360244782867, 9173.81652366949, 1742.8082910879793, 1743.2678275124479, 1753.9649207015916, 1817.0823734014239, 1820.7724034495689, 66538.0, 68110.65944670246, 68602.3139768601, 68915.31084689139, 69252.3074769251, 9562.426254424758, 9742.95128524353, 9902.702918912444, 10052.941764059477, 10170.135538479164, 13909.860901390857, 13950.581482555539, 13953.813925816215, 14014.089084209698, 14020.85979140216, 6737.225219099866, 6827.52207345481, 6876.209235937931, 6885.345892140239, 6991.545549539263, 6189.566730328834, 6202.41077097675, 6233.750649974041, 6297.983341073203, 6416.262129855033, 4083.244599749056, 4273.059926816096, 4308.095299986975, 4314.576189857402, 4421.823127074946, 1644.7039532883957, 1709.3675340123984, 1838.7241913712783, 1902.1915685833465, 1919.280269898788, 840.7561807076002, 843.2705709561185, 868.9913100869037, 995.8804943406838, 1020.9438480883623, 15290.694186116216, 15970.840291596935, 16000.679986400206, 16004.119773412342, 16074.517764467084, 851.4720873058743, 853.5220276645099, 865.1651156633752, 874.4141425245101, 975.5805003848271, 8917.375783695079, 8959.372843900865, 9027.909720902839, 9106.453612783254, 9284.0, 362343.0, 363396.0, 376132.0, 385095.0, 388520.0, 61544.07683884745, 72820.2717972824, 73011.26988730044, 76495.0, 78544.0, 941.463365881441, 947.2942657720042, 948.83869742144, 951.1249650321721, 972.7130496503548, 14201.502947396792, 14434.711305773615, 14474.203918784147, 14487.565373038826, 14494.782578261545, 31314.0, 32378.35243295168, 32507.18732031718, 33115.17212069718, 33483.33033339271, 45888.77055614834, 46618.06763864771, 46697.53302466932, 46780.29829552492, 46808.53191468042, 5421.0, 7288.380487658396, 7372.631368431665, 7525.661345239368, 7779.844403111792, 9052.592633331647, 11177.832332514856, 11339.206255562032, 11503.217001364801, 11585.246958947642, 9647.228221742103, 9716.222702183666, 10177.542010609392, 10199.7450063749, 10231.386116833013, 9654.75863103428, 9892.258080644124, 9931.304808663614, 10040.69877903664, 10132.696019119438, 9320.95339523298, 9724.367916085432, 9906.405615663083, 10109.545070471699, 10182.541785619516, 6667.499937504804, 7071.71713131469, 7171.964140179266, 7288.234735352712, 7725.884111738216, 7847.9215207849475, 9696.660616878375, 10127.291089623655, 10202.591896324064, 10379.06588407047], "value": 7862.489562402138, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.1919415530228, 1463.7511623024084, 1580.4231455518732, 1752.7458518514823, 1778.208697129777, 6940.826479338019, 7533.510321829077, 7540.472166948316, 7753.496022758523, 7792.649330780121, 7522.8119297017465, 7576.280253375934, 7632.084149902005, 7636.732714354998, 7650.846983060335, 2240.11515451397, 2249.3701763506165, 2259.378670865509, 2260.8191344692386, 2281.0191617604423, 2207.746109197447, 2221.9333419997424, 2247.78646028627, 2252.526969336433, 2261.412032871449, 2212.7565967743535, 2236.105557776886, 2236.6197746383154, 2280.783325584067, 2295.276987748862, 2206.6028114939304, 2207.7129973103556, 2213.756486786452, 2218.4453886528368, 2227.365200917731, 2202.5815095131875, 2207.315732123047, 2207.746109197447, 2211.1045026764186, 2215.069670738294, 7637.541747495113, 7741.651625676802, 7768.378529717609, 7778.299953004257, 7800.4149688773, 4610.9308360374625, 4707.8587642370785, 4734.905301893943, 4739.644526660514, 4740.360051393087, 2867.6702179249446, 2873.540233562641, 2897.5798509216047, 2899.9275018124504, 2906.564015397686, 954.5513608603945, 986.9309148359546, 990.1138481059412, 1000.0, 1029.7013865978856, 10307.484625768682, 10315.690529284133, 10364.896351036468, 10369.274150809446, 10442.582296708122, 4157.584241575818, 4209.5579964103945, 4391.516933137353, 4402.669799765031, 4423.203823311835, 8947.32895032875, 9041.90958090424, 9049.864252036225, 9052.954735226282, 9059.909400905906, 4748.0, 4755.2153894607, 4762.095201911626, 4764.618830493552, 4771.594414474739, 3658.323210206067, 4158.896027599334, 4287.6998610097, 4356.019895523482, 4363.0, 3619.1856832213066, 3663.8351274192723, 3706.2402207547925, 3717.386631205875, 3743.1952130292116, 1194.8685644579089, 1202.290648517379, 1207.9758404831855, 1229.9385030748426, 1232.0820988363726, 1039.9948000259951, 1057.6351158850184, 1059.7244716373798, 1132.7224829916722, 1221.3770976801895, 7302.963485182647, 7309.634518274172, 7333.559986400833, 7335.963320183471, 7392.630368481555, 413.5512968429228, 415.5532802237546, 418.56887405971895, 420.46600816962285, 423.2297219061279, 5447.0, 5501.229827824108, 5655.971720141373, 5667.206591077253, 5670.688112153789, 9126.996030436647, 9363.765905852408, 9538.52307384628, 9560.091791279818, 9572.56923438447, 9329.626814927462, 9384.577694003787, 9387.10822471864, 9420.152186303265, 9450.905490945002, 7230.6384680766805, 7237.384822290164, 7315.597642129734, 7350.375218106414, 7384.446166537531, 7045.11936007999, 7158.749443769443, 7172.892406614009, 7181.281871812777, 7190.0, 8742.694005709769, 8788.384813063025, 8835.249003834746, 8876.467411955304, 8994.865077023718, 8744.994325652377, 8806.647734090564, 8826.646934122564, 8874.511901845202, 8926.196642302224, 5835.85654185533, 6701.899471508029, 6742.157230346207, 6845.623490708059, 6924.065251191025, 7271.8909216360735, 7310.561366318038, 7320.487565870338, 7334.559926404433, 7368.189499154982, 6630.9336906630315, 6973.3375329343635, 6993.055937448379, 7015.333543313377, 7092.574445533284, 6887.827804304932, 6964.860702786017, 6965.6168910708375, 7052.047973523714, 7059.223485416703, 7169.533980291264, 7249.383802376857, 7278.944553039673, 7291.635418229173, 7323.377512911462, 6024.8795024100145, 6033.487153591818, 6066.636001839904, 6090.573659843769, 6156.569040167145, 6419.935800642121, 6637.137172167587, 6720.294369091371, 6722.193336799615, 6769.458443324621], "value": 4341.550653353635, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.3054301464169, 309.9752019838413, 313.19821257580594, 314.1392584318964, 319.4633016532228, 5335.306410166678, 5351.839444816657, 5428.972855135728, 5438.368489453158, 5459.481349271813, 5333.4399888011785, 5348.572114230862, 5358.3569971603365, 5368.1679339702405, 5368.382635996862, 3946.2896678597913, 4023.577524359944, 4179.602937720927, 4183.560726123759, 4186.141840922619, 4170.70805043647, 4177.979110104445, 4180.101278225181, 4182.769947652878, 4184.6984158712585, 4116.75299482032, 4159.292920203573, 4169.3954376615375, 4174.394712766647, 4177.916441671165, 4080.36754303085, 4147.751134931884, 4172.7496350218935, 4173.24881521326, 4178.991126388995, 3639.4540818877117, 3648.4709717091137, 3654.104744337628, 3657.140571965586, 3662.8278950735776, 5094.4141423736, 5102.948970510284, 5107.821226257063, 5124.026434977342, 5124.461931497176, 4680.508546602592, 4696.7651617419, 4739.502352253033, 4765.261384485376, 4794.832180873653, 5575.69333686647, 5578.330600327987, 5582.134769110794, 5582.190582365575, 5612.765191657829, 4001.5998400160042, 4006.078601921545, 4006.2988976928923, 4010.5387880393837, 4021.2359651666384, 5777.133429985493, 5879.647221166701, 5913.02435098204, 5923.437273459014, 5934.821955341346, 4112.670986321147, 4135.97932010338, 4144.33690609501, 4146.336586146263, 4148.211839750437, 4155.605217504332, 4165.854195103157, 4174.519930208005, 4202.978985105055, 4206.284931561642, 4424.0, 4712.835050773207, 4717.740524271129, 4756.7145971241835, 4764.523547645277, 5615.831525054255, 5621.4378562144275, 5637.9718101409235, 5642.576806739511, 5646.85882852932, 1389.8818600419077, 1397.8672026157499, 1413.9787903181254, 1420.843707192208, 1422.0, 881.4843316659826, 911.8768966189613, 926.1664501948301, 929.0802105915095, 931.5575101826713, 4934.629902757308, 4939.802407903716, 4946.455889852114, 4952.380952380952, 4959.231319145538, 5704.3154821421695, 5722.2561067061015, 5741.770329186869, 5748.310202775694, 5772.826815195551, 4742.312364707167, 4922.0, 4934.432540257844, 4935.358403407534, 5056.544910957958, 3089.644690860535, 3095.5511450839504, 3116.8000319876555, 3130.201798541357, 3139.937201255962, 5475.09660905946, 5482.998705472473, 5493.835184944458, 5498.1752737089755, 5507.449255074461, 5852.092925596454, 5969.522438204933, 6041.24484439445, 6061.060535616986, 6063.363346848606, 5519.227308176858, 5533.142362933751, 5538.280023596906, 5542.140968149944, 5547.084731019418, 5664.0654292043, 5852.326982397079, 5853.970730146322, 5860.443257890493, 5900.321463031806, 5652.463016013472, 5658.660480371191, 5670.546356291405, 5702.714864256854, 5743.59794814359, 5470.72646367688, 5480.808171713971, 5481.972590137024, 5497.76300332422, 5499.312585926759, 3874.593167717349, 3909.0813658789593, 3913.7104793696008, 3934.468846705658, 3950.9407358890217, 5837.474627283565, 5854.590178687621, 5889.087191485327, 5893.292804863444, 5896.469317761422, 5579.015226853614, 5671.914921276267, 5687.530606330218, 5696.373398926197, 5705.914411283751, 5395.947790180877, 5584.776608935597, 5618.6628802272, 5632.690202038763, 5641.8589535261945, 5275.182346736262, 5511.807086752105, 5536.972315138399, 5554.111342185231, 5573.944260557342, 5459.235707000944, 5587.519307383628, 5665.093585026376, 5671.461211184931, 5686.061799803151, 5541.445855414427, 5542.916856247079, 5553.694546799965, 5561.221429000024, 5561.360443549043], "value": 4221.845733589252, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.3617858766289, 704.8836941904584, 768.488954845028, 777.9222077792222, 783.8667426537488, 12317.0, 12374.752504949896, 12477.812832807514, 12502.0, 12644.747105057893, 11703.239289446201, 11968.102392320567, 12016.158868879182, 12068.517259309618, 12103.21329113607, 640.7084776426738, 783.3928705253417, 791.7268542352908, 805.7018903005896, 815.4454970620005, 798.808286011356, 799.0451410564378, 800.6757263308369, 806.0609390060572, 807.2331285278979, 835.5070508400042, 839.492107275099, 842.3093063687778, 844.3962566764762, 846.4032856835915, 828.1263267253046, 830.2154464031493, 833.5957060825494, 837.5435387713711, 837.7989282572199, 626.2422468812742, 628.4469666693326, 630.593267342566, 631.3497097989078, 631.962082275065, 12243.69390765229, 12324.0, 12333.753324933452, 12354.0734444917, 12355.938220308932, 12735.490580376774, 12819.359032048453, 12837.358132093357, 12909.741805163938, 13133.212007279499, 9759.316847820655, 9842.65550705729, 10209.183265338756, 10266.7433314167, 10268.48657567126, 3365.2764655598917, 3428.674275943806, 3454.602720687103, 3525.7355698322726, 3543.8228088595465, 44931.550684493064, 45153.774231128635, 45240.09519809618, 45879.0, 45896.770516147204, 10110.848337274947, 10134.797304053878, 10193.0, 10262.281640285108, 10436.686899393031, 17694.469165925042, 17841.821581784017, 17887.37394191197, 17905.0, 18032.549186270448, 6732.966335168293, 6767.830804229934, 6810.148731408574, 6945.374916257561, 6955.374016338453, 3713.925721485555, 3769.5288088988877, 3803.980980095137, 3904.590018048121, 3939.3106206413763, 2727.699953005168, 2809.2415047936943, 2814.3667674773014, 2814.6340975673033, 2817.9718202817708, 486.82230985690677, 502.2892606961182, 508.63378367575285, 511.0775051032847, 512.4132867866272, 602.4307029856831, 635.3995474276857, 645.9450946669585, 657.8914479110989, 677.5291172634971, 7822.256885595859, 8119.4722343047515, 8290.792730181673, 8442.915570844212, 8614.827703445895, 598.1038624657617, 670.128832517725, 670.3062330488019, 672.5863593889723, 684.2199892122984, 3849.74976626524, 4005.118873847749, 4049.453323801249, 4054.8986275342763, 4084.65280451159, 48074.759626201645, 48178.0, 48503.0, 48690.75654621704, 48814.0, 42901.0, 43798.56201437945, 43954.0, 43968.56031439709, 44937.10125797466, 39735.0, 40347.394789078186, 40514.79742601268, 41114.0, 41481.792591037454, 7611.540719951371, 7708.344790692854, 7709.498882572615, 7747.767566973, 7869.527828330319, 27789.305267368476, 28567.857160714062, 28845.0, 28942.565861511674, 29086.127416177547, 33723.3255334887, 34609.65390346165, 36460.27079458449, 36490.63509364872, 36734.44898326474, 9452.669156579486, 9567.138957493858, 9711.36876103051, 9762.853557196506, 9818.214542836698, 10198.847017294598, 10267.486625668538, 10267.486625668538, 10530.21023423231, 10671.679849604525, 9321.673741419017, 9713.805723885624, 9941.602335906482, 9974.251931105342, 10227.232957528364, 9932.25508086882, 9971.351862128939, 10323.793524129625, 10332.276740628084, 10721.731956700833, 9908.455034973145, 9918.448533068125, 9998.800023999334, 10266.794664106825, 10406.58373665045, 8034.211862634894, 8054.476459030145, 8311.501309921425, 8425.747227583182, 8639.654413823377, 8350.373721970755, 8728.869066963875, 8778.561071946506, 8782.341324400822, 8886.641783276691], "value": 5828.698900759261, "unit": "score"}], "name": "dromaeo_css", "value": 6304.188135120247, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 108.0, 115.0, 114.0, 115.0, 127.0, 114.0, 114.0, 115.0, 113.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 134.0, 161.0, 176.0, 138.0, 156.0, 167.0, 143.0, 189.0, 135.0], "value": 156.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 165.0, 169.0, 164.0, 164.0, 164.0, 170.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 74.0, 149.0, 75.0, 74.0, 75.0, 74.0, 150.0, 76.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 148.0, 95.0, 95.0, 94.0, 147.0, 95.0, 93.0, 149.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 148.0, 147.0, 147.0, 146.0, 148.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 66.0, 67.0, 68.0, 66.0, 66.0, 78.0, 68.0, 63.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 85.0, 83.0, 86.0, 88.0, 85.0, 86.0, 86.0, 86.0, 86.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 139.0, 147.0, 138.0, 146.0, 148.0, 138.0, 149.0, 177.0, 145.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 170.0, 173.0, 181.0, 180.0, 171.0, 175.0, 171.0, 173.0, 177.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 72.0, 73.0, 77.0, 72.0, 75.0, 74.0, 73.0, 75.0], "value": 73.5, "unit": "score"}], "name": "kraken", "value": 1611.7, "alertThreshold": 2.0}]} 13:06:45 INFO - Return code: 0 13:06:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:06:45 ERROR - # TBPL SUCCESS # 13:06:45 INFO - Running post-action listener: _resource_record_post_action 13:06:45 INFO - Running post-run listener: _resource_record_post_run 13:06:46 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 280670208; Read time: 132; Write time: 177212 13:06:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5791744; Read time: 0; Write time: 396 13:06:46 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 274878464; Read time: 132; Write time: 176816 13:06:46 INFO - Running post-run listener: _upload_blobber_files 13:06:46 INFO - Blob upload gear active. 13:06:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:06:46 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 13:06:46 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'] 13:06:46 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 13:06:47 INFO - (blobuploader) - INFO - Open directory for files ... 13:06:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:06:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:06:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:06:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:06:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:06:48 INFO - (blobuploader) - INFO - Done attempting. 13:06:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:06:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:06:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:06:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:06:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:06:49 INFO - (blobuploader) - INFO - Done attempting. 13:06:49 INFO - (blobuploader) - INFO - Iteration through files over. 13:06:49 INFO - Return code: 0 13:06:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:06:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:06:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/70da17c3ee5f1ff8611e968f567d7cc2b27b0f1c4b3ab2e8c10291ea54bef26b7d1c629f84c25dc6a30988f71046fa799495ce1140f90fc8e7c452e027e5cd6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76799b1993c96f44683c05241f7a7b93af6b3276deb0e485b04b76c2e66aa66e5fb0af3b9715660154d19338d0b2ccb576fab0ce54625dd5fbd66ded6129c009"} 13:06:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:06:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:06:49 INFO - Contents: 13:06:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/70da17c3ee5f1ff8611e968f567d7cc2b27b0f1c4b3ab2e8c10291ea54bef26b7d1c629f84c25dc6a30988f71046fa799495ce1140f90fc8e7c452e027e5cd6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76799b1993c96f44683c05241f7a7b93af6b3276deb0e485b04b76c2e66aa66e5fb0af3b9715660154d19338d0b2ccb576fab0ce54625dd5fbd66ded6129c009"} 13:06:49 INFO - Running post-run listener: copy_logs_to_upload_dir 13:06:49 INFO - Copying logs to upload dir... 13:06:49 INFO - mkdir: /builds/slave/test/build/upload/logs 13:06:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1305.209687 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2016-04-11 13:06:48.299814) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 13:06:48.305773) ========= 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=cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696 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/70da17c3ee5f1ff8611e968f567d7cc2b27b0f1c4b3ab2e8c10291ea54bef26b7d1c629f84c25dc6a30988f71046fa799495ce1140f90fc8e7c452e027e5cd6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76799b1993c96f44683c05241f7a7b93af6b3276deb0e485b04b76c2e66aa66e5fb0af3b9715660154d19338d0b2ccb576fab0ce54625dd5fbd66ded6129c009"} build_url:https://queue.taskcluster.net/v1/task/ALEogmtCSlmWAFHg7VxxHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011246 build_url: 'https://queue.taskcluster.net/v1/task/ALEogmtCSlmWAFHg7VxxHw/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/70da17c3ee5f1ff8611e968f567d7cc2b27b0f1c4b3ab2e8c10291ea54bef26b7d1c629f84c25dc6a30988f71046fa799495ce1140f90fc8e7c452e027e5cd6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/76799b1993c96f44683c05241f7a7b93af6b3276deb0e485b04b76c2e66aa66e5fb0af3b9715660154d19338d0b2ccb576fab0ce54625dd5fbd66ded6129c009"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 13:06:48.330889) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 13:06:48.331242) ========= 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=cbe409c6de289db6ac707de3000001d4-1460403894.949716-1096717696 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004626 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 13:06:48.415666) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 13:06:48.415975) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 13:06:48.416293) ========= ========= Total master_lag: 0.27 =========