builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-063 starttime: 1456835430.69 results: success (0) buildid: 20160301030244 builduid: 9cd00d0abf224634995088b64d45991b revision: 5cafa6f3019b57c43312a75e7d7d58aeb032f1bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:30.695310) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:30.695733) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:30.696021) ========= 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=33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006492 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:30.722861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:30.723178) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:30.818302) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:30.818642) ========= 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=33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004722 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:30.868029) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:30.871419) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:30.871823) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:30.872104) ========= 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=33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 04:30:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-03-01 04:30:32 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172846 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:31.060311) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:31.060642) ========= 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=33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014657 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:31.111015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:31.114454) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5cafa6f3019b57c43312a75e7d7d58aeb032f1bc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5cafa6f3019b57c43312a75e7d7d58aeb032f1bc --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=33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 04:30:32,300 truncating revision to first 12 chars 2016-03-01 04:30:32,300 Setting DEBUG logging. 2016-03-01 04:30:32,300 attempt 1/10 2016-03-01 04:30:32,300 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5cafa6f3019b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 04:30:32,569 unpacking tar archive at: mozilla-central-5cafa6f3019b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560904 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:31.688943) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:31.692312) ========= echo 5cafa6f3019b57c43312a75e7d7d58aeb032f1bc in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5cafa6f3019b57c43312a75e7d7d58aeb032f1bc'] 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=33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 5cafa6f3019b57c43312a75e7d7d58aeb032f1bc program finished with exit code 0 elapsedTime=0.004695 script_repo_revision: '5cafa6f3019b57c43312a75e7d7d58aeb032f1bc' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:31.742111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:31.743384) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 04:30:31.753334) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-01 04:30:31.753606) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:30:33 INFO - MultiFileLogger online at 20160301 04:30:33 in /builds/slave/test 04:30:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:30:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:33 INFO - {'append_to_log': False, 04:30:33 INFO - 'base_work_dir': '/builds/slave/test', 04:30:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:30:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:33 INFO - 'branch': 'Firefox-Non-PGO', 04:30:33 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:33 INFO - 'config_files': ('talos/linux_config.py',), 04:30:33 INFO - 'default_actions': ('clobber', 04:30:33 INFO - 'read-buildbot-config', 04:30:33 INFO - 'download-and-extract', 04:30:33 INFO - 'populate-webroot', 04:30:33 INFO - 'create-virtualenv', 04:30:33 INFO - 'install', 04:30:33 INFO - 'run-tests'), 04:30:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:33 INFO - 'download_minidump_stackwalk': True, 04:30:33 INFO - 'download_symbols': 'ondemand', 04:30:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:33 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:33 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:33 INFO - 'installer_path': 'installer.exe', 04:30:33 INFO - 'log_level': 'info', 04:30:33 INFO - 'log_name': 'talos', 04:30:33 INFO - 'log_to_console': True, 04:30:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:30:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:30:33 INFO - 'opt_config_files': (), 04:30:33 INFO - 'pip_index': False, 04:30:33 INFO - 'sps_profile': False, 04:30:33 INFO - 'sps_profile_interval': 0, 04:30:33 INFO - 'suite': 'dromaeojs', 04:30:33 INFO - 'system_bits': '32', 04:30:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:33 INFO - 'title': 'talos-linux64-ix-063', 04:30:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:33 INFO - 'use_talos_json': True, 04:30:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:33 INFO - 'work_dir': 'build'} 04:30:33 INFO - ##### 04:30:33 INFO - ##### Running clobber step. 04:30:33 INFO - ##### 04:30:33 INFO - Running pre-action listener: _resource_record_pre_action 04:30:33 INFO - Running main action method: clobber 04:30:33 INFO - rmtree: /builds/slave/test/build 04:30:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:33 INFO - Running post-action listener: _resource_record_post_action 04:30:33 INFO - ##### 04:30:33 INFO - ##### Running read-buildbot-config step. 04:30:33 INFO - ##### 04:30:33 INFO - Running pre-action listener: _resource_record_pre_action 04:30:33 INFO - Running main action method: read_buildbot_config 04:30:33 INFO - Using buildbot properties: 04:30:33 INFO - { 04:30:33 INFO - "project": "", 04:30:33 INFO - "product": "firefox", 04:30:33 INFO - "script_repo_revision": "production", 04:30:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:30:33 INFO - "repository": "", 04:30:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:30:33 INFO - "buildid": "20160301030244", 04:30:33 INFO - "pgo_build": "False", 04:30:33 INFO - "basedir": "/builds/slave/test", 04:30:33 INFO - "buildnumber": 4, 04:30:33 INFO - "slavename": "talos-linux64-ix-063", 04:30:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:30:33 INFO - "platform": "ubuntu64_hw", 04:30:33 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:30:33 INFO - "branch": "mozilla-central", 04:30:33 INFO - "repo_path": "mozilla-central", 04:30:33 INFO - "revision": "5cafa6f3019b57c43312a75e7d7d58aeb032f1bc", 04:30:33 INFO - "stage_platform": "linux64", 04:30:33 INFO - "builduid": "9cd00d0abf224634995088b64d45991b", 04:30:33 INFO - "slavebuilddir": "test" 04:30:33 INFO - } 04:30:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 04:30:33 INFO - Running post-action listener: _resource_record_post_action 04:30:33 INFO - ##### 04:30:33 INFO - ##### Running download-and-extract step. 04:30:33 INFO - ##### 04:30:33 INFO - Running pre-action listener: _resource_record_pre_action 04:30:33 INFO - Running main action method: download_and_extract 04:30:33 INFO - mkdir: /builds/slave/test/build/tests 04:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:33 INFO - https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:30:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 04:30:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 04:30:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 04:30:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:30:34 INFO - Downloaded 1448 bytes. 04:30:34 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 04:30:34 INFO - Using the following test package requirements: 04:30:34 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:34 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:30:34 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:30:34 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:34 INFO - u'jsshell-linux-x86_64.zip'], 04:30:34 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:30:34 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:34 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:30:34 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:30:34 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:30:34 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:34 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:34 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:30:34 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:30: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')]} 04:30:34 INFO - https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:30:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:30:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:30:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:30:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:30:35 INFO - Downloaded 22077321 bytes. 04:30:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:30:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:30:36 INFO - Return code: 0 04:30:36 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:36 INFO - https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:30:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:30:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:30:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:30:38 INFO - Downloaded 22077321 bytes. 04:30:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:30:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:30:39 INFO - Return code: 0 04:30: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')]} 04:30:39 INFO - https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:30:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:30:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:30:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:30:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:30:41 INFO - Downloaded 10713413 bytes. 04:30:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:30:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:30:41 INFO - Return code: 0 04:30: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')]} 04:30:41 INFO - https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:30:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:30:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:30:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:30:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:30:42 INFO - Downloaded 54835213 bytes. 04:30:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:30:42 INFO - mkdir: /builds/slave/test/properties 04:30:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:30:42 INFO - Writing to file /builds/slave/test/properties/build_url 04:30:42 INFO - Contents: 04:30:42 INFO - build_url:https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:30:43 INFO - Running post-action listener: _resource_record_post_action 04:30:43 INFO - Running post-action listener: set_extra_try_arguments 04:30:43 INFO - ##### 04:30:43 INFO - ##### Running populate-webroot step. 04:30:43 INFO - ##### 04:30:43 INFO - Running pre-action listener: _resource_record_pre_action 04:30:43 INFO - Running main action method: populate_webroot 04:30:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:30:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:30:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:30:43 INFO - '--tppagecycles', 04:30:43 INFO - '7'], 04:30:43 INFO - 'tests': ['tsvgm']}}, 04:30:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:30:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:30:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:30:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:30:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:30:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:30:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:43 INFO - 'talos_options': ['--e10s'], 04:30:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:43 INFO - 'tests': ['damp', 'tps']}, 04:30:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:43 INFO - 'talos_options': ['--e10s'], 04:30:43 INFO - 'tests': ['damp', 'tps']}, 04:30:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:30:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:30:43 INFO - 'other': {'tests': ['a11yr', 04:30:43 INFO - 'ts_paint', 04:30:43 INFO - 'tpaint', 04:30:43 INFO - 'sessionrestore', 04:30:43 INFO - 'sessionrestore_no_auto_restore']}, 04:30:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:30:43 INFO - 'tests': ['a11yr', 04:30:43 INFO - 'ts_paint', 04:30:43 INFO - 'tpaint', 04:30:43 INFO - 'sessionrestore', 04:30:43 INFO - 'sessionrestore_no_auto_restore']}, 04:30:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:30:43 INFO - 'tests': ['a11yr', 04:30:43 INFO - 'ts_paint', 04:30:43 INFO - 'tpaint', 04:30:43 INFO - 'sessionrestore', 04:30:43 INFO - 'sessionrestore_no_auto_restore']}, 04:30:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:30:43 INFO - 'tests': ['a11yr', 04:30:43 INFO - 'ts_paint', 04:30:43 INFO - 'tpaint', 04:30:43 INFO - 'sessionrestore', 04:30:43 INFO - 'sessionrestore_no_auto_restore']}, 04:30:43 INFO - 'other_l64': {'tests': ['a11yr', 04:30:43 INFO - 'ts_paint', 04:30:43 INFO - 'tpaint', 04:30:43 INFO - 'sessionrestore', 04:30:43 INFO - 'sessionrestore_no_auto_restore']}, 04:30:43 INFO - 'other_nol64': {'tests': ['a11yr', 04:30:43 INFO - 'ts_paint', 04:30:43 INFO - 'tpaint', 04:30:43 INFO - 'sessionrestore', 04:30:43 INFO - 'sessionrestore_no_auto_restore']}, 04:30:43 INFO - 'svgr': {'tests': ['tsvgx', 04:30:43 INFO - 'tsvgr_opacity', 04:30:43 INFO - 'tart', 04:30:43 INFO - 'tscrollx', 04:30:43 INFO - 'cart']}, 04:30:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:30:43 INFO - 'tests': ['tsvgx', 04:30:43 INFO - 'tsvgr_opacity', 04:30:43 INFO - 'tart', 04:30:43 INFO - 'tscrollx', 04:30:43 INFO - 'cart']}, 04:30:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:43 INFO - 'tests': ['tp5o']}, 04:30:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:43 INFO - 'talos_options': ['--e10s'], 04:30:43 INFO - 'tests': ['tp5o']}, 04:30:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:43 INFO - 'talos_options': ['--xperf_path', 04:30:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:43 INFO - 'tests': ['tp5n']}, 04:30:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:43 INFO - 'talos_options': ['--e10s', 04:30:43 INFO - '--xperf_path', 04:30:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:43 INFO - 'tests': ['tp5n']}}, 04:30:43 INFO - 'talos.zip': {'path': '', 04:30:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:30:43 INFO - Running post-action listener: _resource_record_post_action 04:30:43 INFO - ##### 04:30:43 INFO - ##### Running create-virtualenv step. 04:30:43 INFO - ##### 04:30:43 INFO - Running pre-action listener: _resource_record_pre_action 04:30:43 INFO - Running main action method: create_virtualenv 04:30:43 INFO - Creating virtualenv /builds/slave/test/build/venv 04:30:43 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 04:30:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:30:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:30:43 INFO - Using real prefix '/usr' 04:30:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:30:44 INFO - Installing distribute.............................................................................................................................................................................................done. 04:30:46 INFO - Installing pip.................done. 04:30:46 INFO - Return code: 0 04:30:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f345618af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f9100>, '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 0x23fa000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fa490>, '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': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', '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 04:30:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:30:46 INFO - Using env: {'DISPLAY': ':0', 04:30:46 INFO - 'HOME': '/home/cltbld', 04:30:46 INFO - 'LANG': 'en_US.UTF-8', 04:30:46 INFO - 'LANGUAGE': 'en_US:en', 04:30:46 INFO - 'LOGNAME': 'cltbld', 04:30:46 INFO - 'MAIL': '/var/mail/cltbld', 04:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:46 INFO - 'MOZ_NO_REMOTE': '1', 04:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:46 INFO - 'NO_EM_RESTART': '1', 04:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:46 INFO - 'PWD': '/builds/slave/test', 04:30:46 INFO - 'SHELL': '/bin/bash', 04:30:46 INFO - 'SHLVL': '1', 04:30:46 INFO - 'TERM': 'linux', 04:30:46 INFO - 'TMOUT': '86400', 04:30:46 INFO - 'USER': 'cltbld', 04:30:46 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', 04:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:46 INFO - '_': '/tools/buildbot/bin/python'} 04:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:46 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 04:30:46 INFO - Cleaning up... 04:30:46 INFO - Return code: 0 04:30:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f345618af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f9100>, '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 0x23fa000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fa490>, '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': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', '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 04:30:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:30:46 INFO - Using env: {'DISPLAY': ':0', 04:30:46 INFO - 'HOME': '/home/cltbld', 04:30:46 INFO - 'LANG': 'en_US.UTF-8', 04:30:46 INFO - 'LANGUAGE': 'en_US:en', 04:30:46 INFO - 'LOGNAME': 'cltbld', 04:30:46 INFO - 'MAIL': '/var/mail/cltbld', 04:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:46 INFO - 'MOZ_NO_REMOTE': '1', 04:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:46 INFO - 'NO_EM_RESTART': '1', 04:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:46 INFO - 'PWD': '/builds/slave/test', 04:30:46 INFO - 'SHELL': '/bin/bash', 04:30:46 INFO - 'SHLVL': '1', 04:30:46 INFO - 'TERM': 'linux', 04:30:46 INFO - 'TMOUT': '86400', 04:30:46 INFO - 'USER': 'cltbld', 04:30:46 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', 04:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:46 INFO - '_': '/tools/buildbot/bin/python'} 04:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:46 INFO - Downloading/unpacking psutil>=0.7.1 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:30:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:48 INFO - Installing collected packages: psutil 04:30:48 INFO - Running setup.py install for psutil 04:30:48 INFO - building 'psutil._psutil_linux' extension 04:30:48 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 04:30:48 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 04:30:48 INFO - building 'psutil._psutil_posix' extension 04:30:48 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 04:30:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:30:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:49 INFO - Successfully installed psutil 04:30:49 INFO - Cleaning up... 04:30:49 INFO - Return code: 0 04:30:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:49 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 0x7f345618af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f9100>, '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 0x23fa000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fa490>, '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': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', '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 04:30:49 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 04:30:49 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 04:30:49 INFO - Using env: {'DISPLAY': ':0', 04:30:49 INFO - 'HOME': '/home/cltbld', 04:30:49 INFO - 'LANG': 'en_US.UTF-8', 04:30:49 INFO - 'LANGUAGE': 'en_US:en', 04:30:49 INFO - 'LOGNAME': 'cltbld', 04:30:49 INFO - 'MAIL': '/var/mail/cltbld', 04:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:49 INFO - 'MOZ_NO_REMOTE': '1', 04:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:49 INFO - 'NO_EM_RESTART': '1', 04:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:49 INFO - 'PWD': '/builds/slave/test', 04:30:49 INFO - 'SHELL': '/bin/bash', 04:30:49 INFO - 'SHLVL': '1', 04:30:49 INFO - 'TERM': 'linux', 04:30:49 INFO - 'TMOUT': '86400', 04:30:49 INFO - 'USER': 'cltbld', 04:30:49 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', 04:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:49 INFO - '_': '/tools/buildbot/bin/python'} 04:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:30:49 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 04:30:49 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 04:30:49 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 04:30:49 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 04:30:49 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 04:30:49 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 04:30:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:30:51 INFO - Installing collected packages: mozsystemmonitor 04:30:51 INFO - Running setup.py install for mozsystemmonitor 04:30:51 INFO - Successfully installed mozsystemmonitor 04:30:51 INFO - Cleaning up... 04:30:51 INFO - Return code: 0 04:30:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:30:51 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')]} 04:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:51 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')]} 04:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:51 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 0x7f345618af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f9100>, '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 0x23fa000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fa490>, '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': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', '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 04:30:51 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 04:30:51 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 04:30:51 INFO - Using env: {'DISPLAY': ':0', 04:30:51 INFO - 'HOME': '/home/cltbld', 04:30:51 INFO - 'LANG': 'en_US.UTF-8', 04:30:51 INFO - 'LANGUAGE': 'en_US:en', 04:30:51 INFO - 'LOGNAME': 'cltbld', 04:30:51 INFO - 'MAIL': '/var/mail/cltbld', 04:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:51 INFO - 'MOZ_NO_REMOTE': '1', 04:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:51 INFO - 'NO_EM_RESTART': '1', 04:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:51 INFO - 'PWD': '/builds/slave/test', 04:30:51 INFO - 'SHELL': '/bin/bash', 04:30:51 INFO - 'SHLVL': '1', 04:30:51 INFO - 'TERM': 'linux', 04:30:51 INFO - 'TMOUT': '86400', 04:30:51 INFO - 'USER': 'cltbld', 04:30:51 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', 04:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:51 INFO - '_': '/tools/buildbot/bin/python'} 04:30:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:51 INFO - Downloading/unpacking blobuploader==1.2.4 04:30:51 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 04:30:51 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 04:30:51 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 04:30:51 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 04:30:51 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 04:30:51 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 04:30:53 INFO - Downloading blobuploader-1.2.4.tar.gz 04:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:30:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:30:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 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 04:30:53 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 04:30:54 INFO - Downloading docopt-0.6.1.tar.gz 04:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:30:54 INFO - Installing collected packages: blobuploader, requests, docopt 04:30:54 INFO - Running setup.py install for blobuploader 04:30:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:30:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:30:54 INFO - Running setup.py install for requests 04:30:54 INFO - Running setup.py install for docopt 04:30:54 INFO - Successfully installed blobuploader requests docopt 04:30:54 INFO - Cleaning up... 04:30:54 INFO - Return code: 0 04:30:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:54 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 0x7f345618af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f9100>, '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 0x23fa000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fa490>, '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': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', '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 04:30:54 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 04:30:54 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 04:30:54 INFO - Using env: {'DISPLAY': ':0', 04:30:54 INFO - 'HOME': '/home/cltbld', 04:30:54 INFO - 'LANG': 'en_US.UTF-8', 04:30:54 INFO - 'LANGUAGE': 'en_US:en', 04:30:54 INFO - 'LOGNAME': 'cltbld', 04:30:54 INFO - 'MAIL': '/var/mail/cltbld', 04:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:54 INFO - 'MOZ_NO_REMOTE': '1', 04:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:54 INFO - 'NO_EM_RESTART': '1', 04:30:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:54 INFO - 'PWD': '/builds/slave/test', 04:30:54 INFO - 'SHELL': '/bin/bash', 04:30:54 INFO - 'SHLVL': '1', 04:30:54 INFO - 'TERM': 'linux', 04:30:54 INFO - 'TMOUT': '86400', 04:30:54 INFO - 'USER': 'cltbld', 04:30:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', 04:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:54 INFO - '_': '/tools/buildbot/bin/python'} 04:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:55 INFO - Running setup.py (path:/tmp/pip-DRPz9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:55 INFO - Running setup.py (path:/tmp/pip-GlnAXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:55 INFO - Running setup.py (path:/tmp/pip-iIGTjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:55 INFO - Running setup.py (path:/tmp/pip-sHOJd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:55 INFO - Running setup.py (path:/tmp/pip-wCzhXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:55 INFO - Running setup.py (path:/tmp/pip-I_s7od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:55 INFO - Running setup.py (path:/tmp/pip-uiIIpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:55 INFO - Running setup.py (path:/tmp/pip-DXCYuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:55 INFO - Running setup.py (path:/tmp/pip-fOEVJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:55 INFO - Running setup.py (path:/tmp/pip-Rqhhc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:55 INFO - Running setup.py (path:/tmp/pip-DTH_7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:55 INFO - Running setup.py (path:/tmp/pip-f_BrCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:55 INFO - Running setup.py (path:/tmp/pip-w36cbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:56 INFO - Running setup.py (path:/tmp/pip-ovrgnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:56 INFO - Running setup.py (path:/tmp/pip-xr3xEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:56 INFO - Running setup.py (path:/tmp/pip-9LMXPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:56 INFO - Running setup.py (path:/tmp/pip-NJlca3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:30:56 INFO - Running setup.py install for manifestparser 04:30:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Running setup.py install for mozcrash 04:30:56 INFO - Running setup.py install for mozdebug 04:30:56 INFO - Running setup.py install for mozdevice 04:30:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Running setup.py install for mozfile 04:30:56 INFO - Running setup.py install for mozhttpd 04:30:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:30:56 INFO - Running setup.py install for mozinfo 04:30:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Running setup.py install for mozInstall 04:30:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Running setup.py install for mozleak 04:30:57 INFO - Running setup.py install for mozlog 04:30:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Running setup.py install for moznetwork 04:30:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Running setup.py install for mozprocess 04:30:57 INFO - Running setup.py install for mozprofile 04:30:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Running setup.py install for mozrunner 04:30:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:30:57 INFO - Running setup.py install for mozscreenshot 04:30:57 INFO - Running setup.py install for moztest 04:30:57 INFO - Running setup.py install for mozversion 04:30:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:30:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:30:58 INFO - Cleaning up... 04:30:58 INFO - Return code: 0 04:30:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:58 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 0x7f345618af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f9100>, '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 0x23fa000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fa490>, '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': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', '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 04:30:58 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 04:30:58 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 04:30:58 INFO - Using env: {'DISPLAY': ':0', 04:30:58 INFO - 'HOME': '/home/cltbld', 04:30:58 INFO - 'LANG': 'en_US.UTF-8', 04:30:58 INFO - 'LANGUAGE': 'en_US:en', 04:30:58 INFO - 'LOGNAME': 'cltbld', 04:30:58 INFO - 'MAIL': '/var/mail/cltbld', 04:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:58 INFO - 'MOZ_NO_REMOTE': '1', 04:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:58 INFO - 'NO_EM_RESTART': '1', 04:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:58 INFO - 'PWD': '/builds/slave/test', 04:30:58 INFO - 'SHELL': '/bin/bash', 04:30:58 INFO - 'SHLVL': '1', 04:30:58 INFO - 'TERM': 'linux', 04:30:58 INFO - 'TMOUT': '86400', 04:30:58 INFO - 'USER': 'cltbld', 04:30:58 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', 04:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:58 INFO - '_': '/tools/buildbot/bin/python'} 04:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:58 INFO - Running setup.py (path:/tmp/pip-Zh_jcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:58 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)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:58 INFO - Running setup.py (path:/tmp/pip-VBg43z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:58 INFO - Running setup.py (path:/tmp/pip-uIDAJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:58 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)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:58 INFO - Running setup.py (path:/tmp/pip-Bm2E0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:58 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)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:58 INFO - Running setup.py (path:/tmp/pip-FQFw_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:58 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)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:58 INFO - Running setup.py (path:/tmp/pip-Qp35bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:58 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)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:58 INFO - Running setup.py (path:/tmp/pip-Z9l6vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:58 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)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:58 INFO - Running setup.py (path:/tmp/pip-pKKvvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:58 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)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:58 INFO - Running setup.py (path:/tmp/pip-FGMuqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:58 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)) 04:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:59 INFO - Running setup.py (path:/tmp/pip-Tj8kn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:59 INFO - Running setup.py (path:/tmp/pip-ovYhYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:59 INFO - Running setup.py (path:/tmp/pip-fYGgCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:59 INFO - Running setup.py (path:/tmp/pip-1DJHp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:59 INFO - Running setup.py (path:/tmp/pip-r4MAY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:59 INFO - Running setup.py (path:/tmp/pip-QHT3Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:59 INFO - Running setup.py (path:/tmp/pip-9z70v2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:59 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)) 04:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:59 INFO - Running setup.py (path:/tmp/pip-40vqFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:59 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)) 04:30:59 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:30:59 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:30:59 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)) 04:30:59 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)) 04:30:59 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)) 04:30:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:30:59 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 04:30:59 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 04:30:59 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 04:30:59 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 04:30:59 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 04:30:59 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 04:31:01 INFO - Downloading blessings-1.6.tar.gz 04:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:01 INFO - Installing collected packages: blessings 04:31:01 INFO - Running setup.py install for blessings 04:31:01 INFO - Successfully installed blessings 04:31:01 INFO - Cleaning up... 04:31:01 INFO - Return code: 0 04:31:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:01 INFO - Reading from file tmpfile_stdout 04:31:01 INFO - Current package versions: 04:31:01 INFO - argparse == 1.2.1 04:31:01 INFO - blessings == 1.6 04:31:01 INFO - blobuploader == 1.2.4 04:31:01 INFO - docopt == 0.6.1 04:31:01 INFO - manifestparser == 1.1 04:31:01 INFO - mozInstall == 1.12 04:31:01 INFO - mozcrash == 0.16 04:31:01 INFO - mozdebug == 0.1 04:31:01 INFO - mozdevice == 0.48 04:31:01 INFO - mozfile == 1.2 04:31:01 INFO - mozhttpd == 0.7 04:31:01 INFO - mozinfo == 0.9 04:31:01 INFO - mozleak == 0.1 04:31:01 INFO - mozlog == 3.1 04:31:01 INFO - moznetwork == 0.27 04:31:01 INFO - mozprocess == 0.22 04:31:01 INFO - mozprofile == 0.28 04:31:01 INFO - mozrunner == 6.11 04:31:01 INFO - mozscreenshot == 0.1 04:31:01 INFO - mozsystemmonitor == 0.0 04:31:01 INFO - moztest == 0.7 04:31:01 INFO - mozversion == 1.4 04:31:01 INFO - psutil == 3.1.1 04:31:01 INFO - requests == 1.2.3 04:31:01 INFO - wsgiref == 0.1.2 04:31:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:01 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 0x7f345618af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f9100>, '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 0x23fa000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fa490>, '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': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', '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 04:31:01 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 04:31:01 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 04:31:01 INFO - Using env: {'DISPLAY': ':0', 04:31:01 INFO - 'HOME': '/home/cltbld', 04:31:01 INFO - 'LANG': 'en_US.UTF-8', 04:31:01 INFO - 'LANGUAGE': 'en_US:en', 04:31:01 INFO - 'LOGNAME': 'cltbld', 04:31:01 INFO - 'MAIL': '/var/mail/cltbld', 04:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:01 INFO - 'MOZ_NO_REMOTE': '1', 04:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:01 INFO - 'NO_EM_RESTART': '1', 04:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:01 INFO - 'PWD': '/builds/slave/test', 04:31:01 INFO - 'SHELL': '/bin/bash', 04:31:01 INFO - 'SHLVL': '1', 04:31:01 INFO - 'TERM': 'linux', 04:31:01 INFO - 'TMOUT': '86400', 04:31:01 INFO - 'USER': 'cltbld', 04:31:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', 04:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:01 INFO - '_': '/tools/buildbot/bin/python'} 04:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:02 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)) 04:31:02 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)) 04:31:02 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)) 04:31:02 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)) 04:31:02 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)) 04:31:02 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)) 04:31:02 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)) 04:31:02 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)) 04:31:02 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)) 04:31:02 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)) 04:31:02 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)) 04:31:02 INFO - Cleaning up... 04:31:02 INFO - Return code: 0 04:31:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:02 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 0x7f345618af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f9100>, '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 0x23fa000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fa490>, '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': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', '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 04:31:02 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 04:31:02 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 04:31:02 INFO - Using env: {'DISPLAY': ':0', 04:31:02 INFO - 'HOME': '/home/cltbld', 04:31:02 INFO - 'LANG': 'en_US.UTF-8', 04:31:02 INFO - 'LANGUAGE': 'en_US:en', 04:31:02 INFO - 'LOGNAME': 'cltbld', 04:31:02 INFO - 'MAIL': '/var/mail/cltbld', 04:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:02 INFO - 'MOZ_NO_REMOTE': '1', 04:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:02 INFO - 'NO_EM_RESTART': '1', 04:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:02 INFO - 'PWD': '/builds/slave/test', 04:31:02 INFO - 'SHELL': '/bin/bash', 04:31:02 INFO - 'SHLVL': '1', 04:31:02 INFO - 'TERM': 'linux', 04:31:02 INFO - 'TMOUT': '86400', 04:31:02 INFO - 'USER': 'cltbld', 04:31:02 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', 04:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:02 INFO - '_': '/tools/buildbot/bin/python'} 04:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:02 INFO - Downloading/unpacking jsonschema 04:31:02 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 04:31:02 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 04:31:02 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 04:31:02 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 04:31:02 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 04:31:02 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 04:31:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:04 INFO - Downloading/unpacking functools32 (from jsonschema) 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:04 INFO - warning: no files found matching '*.txt' 04:31:04 INFO - no previously-included directories found matching 'build' 04:31:04 INFO - no previously-included directories found matching 'dist' 04:31:04 INFO - no previously-included directories found matching '.git*' 04:31:04 INFO - Installing collected packages: jsonschema, functools32 04:31:04 INFO - Running setup.py install for functools32 04:31:04 INFO - warning: no files found matching '*.txt' 04:31:04 INFO - no previously-included directories found matching 'build' 04:31:04 INFO - no previously-included directories found matching 'dist' 04:31:04 INFO - no previously-included directories found matching '.git*' 04:31:04 INFO - Successfully installed jsonschema functools32 04:31:04 INFO - Cleaning up... 04:31:04 INFO - Return code: 0 04:31:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f345618af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x236a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f9100>, '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 0x23fa000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fa490>, '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': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', '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 04:31:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:31:04 INFO - Using env: {'DISPLAY': ':0', 04:31:04 INFO - 'HOME': '/home/cltbld', 04:31:04 INFO - 'LANG': 'en_US.UTF-8', 04:31:04 INFO - 'LANGUAGE': 'en_US:en', 04:31:04 INFO - 'LOGNAME': 'cltbld', 04:31:04 INFO - 'MAIL': '/var/mail/cltbld', 04:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:04 INFO - 'MOZ_NO_REMOTE': '1', 04:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:04 INFO - 'NO_EM_RESTART': '1', 04:31:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:04 INFO - 'PWD': '/builds/slave/test', 04:31:04 INFO - 'SHELL': '/bin/bash', 04:31:04 INFO - 'SHLVL': '1', 04:31:04 INFO - 'TERM': 'linux', 04:31:04 INFO - 'TMOUT': '86400', 04:31:04 INFO - 'USER': 'cltbld', 04:31:04 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', 04:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:04 INFO - '_': '/tools/buildbot/bin/python'} 04:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:04 INFO - Downloading/unpacking flake8 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:31:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:31:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:31:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:07 INFO - no previously-included directories found matching 'docs/_build' 04:31:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:31:07 INFO - Running setup.py install for pep8 04:31:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:07 INFO - no previously-included directories found matching 'docs/_build' 04:31:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:31:07 INFO - Cleaning up... 04:31:07 INFO - Return code: 0 04:31:07 INFO - Running post-action listener: _resource_record_post_action 04:31:07 INFO - Running post-action listener: _start_resource_monitoring 04:31:07 INFO - Starting resource monitoring. 04:31:07 INFO - ##### 04:31:07 INFO - ##### Running install step. 04:31:07 INFO - ##### 04:31:07 INFO - Running pre-action listener: _resource_record_pre_action 04:31:07 INFO - Running main action method: install 04:31:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:07 INFO - Reading from file tmpfile_stdout 04:31:07 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:07 INFO - Reading from file tmpfile_stdout 04:31:07 INFO - Output received: 04:31:07 INFO - Usage: mozinstall [options] installer 04:31:07 INFO - Options: 04:31:07 INFO - -h, --help show this help message and exit 04:31:07 INFO - -d DEST, --destination=DEST 04:31:07 INFO - Directory to install application into. [default: 04:31:07 INFO - "/builds/slave/test"] 04:31:07 INFO - --app=APP Application being installed. [default: firefox] 04:31:07 INFO - mkdir: /builds/slave/test/build/application 04:31:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:31:23 INFO - Reading from file tmpfile_stdout 04:31:23 INFO - Output received: 04:31:23 INFO - /builds/slave/test/build/application/firefox/firefox 04:31:23 INFO - Running post-action listener: _resource_record_post_action 04:31:23 INFO - ##### 04:31:23 INFO - ##### Running run-tests step. 04:31:23 INFO - ##### 04:31:23 INFO - Running pre-action listener: _resource_record_pre_action 04:31:23 INFO - Running main action method: run_tests 04:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:23 INFO - Python 2.7.3 04:31:23 INFO - Return code: 0 04:31:23 INFO - grabbing minidump binary from tooltool 04:31:23 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')]} 04:31:23 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 0x23f9100>, '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 0x23fa000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23fa490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31:23 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 04:31:23 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 04:31:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:23 INFO - Return code: 0 04:31:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:31:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:31:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:31:24 INFO - Return code: 0 04:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:31:24 INFO - Using env: {'DISPLAY': ':0', 04:31:24 INFO - 'HOME': '/home/cltbld', 04:31:24 INFO - 'LANG': 'en_US.UTF-8', 04:31:24 INFO - 'LANGUAGE': 'en_US:en', 04:31:24 INFO - 'LOGNAME': 'cltbld', 04:31:24 INFO - 'MAIL': '/var/mail/cltbld', 04:31:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:31:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:24 INFO - 'MOZ_NO_REMOTE': '1', 04:31:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:24 INFO - 'NO_EM_RESTART': '1', 04:31:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:24 INFO - 'PWD': '/builds/slave/test', 04:31:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:31:24 INFO - 'SHELL': '/bin/bash', 04:31:24 INFO - 'SHLVL': '1', 04:31:24 INFO - 'TERM': 'linux', 04:31:24 INFO - 'TMOUT': '86400', 04:31:24 INFO - 'USER': 'cltbld', 04:31:24 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584', 04:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:24 INFO - '_': '/tools/buildbot/bin/python'} 04:31:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:31:25 INFO - mozversion application_buildid: 20160301030244 04:31:25 INFO - mozversion application_changeset: 5cafa6f3019b57c43312a75e7d7d58aeb032f1bc 04:31:25 INFO - mozversion application_display_name: Nightly 04:31:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:25 INFO - mozversion application_name: Firefox 04:31:25 INFO - mozversion application_remotingname: firefox 04:31:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:31:25 INFO - mozversion application_vendor: Mozilla 04:31:25 INFO - mozversion application_version: 47.0a1 04:31:25 INFO - mozversion platform_buildid: 20160301030244 04:31:25 INFO - mozversion platform_changeset: 5cafa6f3019b57c43312a75e7d7d58aeb032f1bc 04:31:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:31:25 INFO - mozversion platform_version: 47.0a1 04:31:25 INFO - using testdate: 1456835485 04:31:25 INFO - actual date: 1456835485 04:31:25 INFO - starting webserver on 'localhost:44514' 04:31:25 INFO - SUITE-START | Running 2 tests 04:31:25 INFO - TEST-START | dromaeo_css 04:31:25 INFO - operating with platform_type : linux_ 04:31:25 INFO - Initialising browser for dromaeo_css test... 04:31:25 INFO - TEST-INFO | started process 23158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzbA0ir/profile http://localhost:44514/getInfo.html) 04:31:29 INFO - PROCESS | 23158 | __metrics Screen width/height:1600/1200 04:31:29 INFO - PROCESS | 23158 | colorDepth:24 04:31:29 INFO - PROCESS | 23158 | Browser inner width/height: 1024/697 04:31:29 INFO - PROCESS | 23158 | __metrics 04:31:30 INFO - PROCESS | 23158 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:31:30 INFO - PROCESS | 23158 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:31:30 INFO - PROCESS | 23158 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:31:30 INFO - PROCESS | 23158 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:31:30 INFO - PROCESS | 23158 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:31:30 INFO - PROCESS | 23158 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:31:30 INFO - PROCESS | 23158 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:31:30 INFO - PROCESS | 23158 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:31:31 INFO - TEST-INFO | 23158: exit 0 04:31:31 INFO - Browser initialized. 04:31:31 INFO - Running cycle 1/1 for dromaeo_css test... 04:31:31 INFO - TEST-INFO | started process 23252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzbA0ir/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:43 INFO - PROCESS | 23252 | RSS: Main: 153440256 04:31:43 INFO - PROCESS | 23252 | 04:32:33 INFO - PROCESS | 23252 | 1456835553982 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] 04:34:45 INFO - PROCESS | 23252 | Cycle 1(1): loaded http://localhost:44514/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44514/tests/dromaeo/cssquery-ext.html) 04:34:46 INFO - PROCESS | 23252 | RSS: Main: 240480256 04:34:46 INFO - PROCESS | 23252 | 04:37:48 INFO - PROCESS | 23252 | Cycle 1(1): loaded http://localhost:44514/tests/dromaeo/cssquery-ext.html (next: http://localhost:44514/tests/dromaeo/cssquery-jquery.html) 04:37:49 INFO - PROCESS | 23252 | RSS: Main: 230502400 04:37:49 INFO - PROCESS | 23252 | 04:40:51 INFO - PROCESS | 23252 | Cycle 1(1): loaded http://localhost:44514/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44514/tests/dromaeo/cssquery-mootools.html) 04:40:51 INFO - PROCESS | 23252 | RSS: Main: 226848768 04:40:51 INFO - PROCESS | 23252 | 04:43:53 INFO - PROCESS | 23252 | Cycle 1(1): loaded http://localhost:44514/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44514/tests/dromaeo/cssquery-prototype.html) 04:43:54 INFO - PROCESS | 23252 | RSS: Main: 203628544 04:43:54 INFO - PROCESS | 23252 | 04:46:57 INFO - PROCESS | 23252 | Cycle 1(1): loaded http://localhost:44514/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44514/tests/dromaeo/cssquery-yui.html) 04:46:57 INFO - PROCESS | 23252 | RSS: Main: 194863104 04:46:57 INFO - PROCESS | 23252 | 04:50:00 INFO - PROCESS | 23252 | Cycle 1(1): loaded http://localhost:44514/tests/dromaeo/cssquery-yui.html (next: http://localhost:44514/tests/dromaeo/cssquery-dojo.html) 04:50:00 INFO - PROCESS | 23252 | RSS: Main: 268316672 04:50:00 INFO - PROCESS | 23252 | 04:50:00 INFO - PROCESS | 23252 | __start_tp_report 04:50:00 INFO - PROCESS | 23252 | _x_x_mozilla_page_load 04:50:00 INFO - PROCESS | 23252 | _x_x_mozilla_page_load_details 04:50:00 INFO - PROCESS | 23252 | |i|pagename|runs| 04:50:00 INFO - PROCESS | 23252 | |0;dojo.html;2577.729338419466;2639.379745759746;2644.6165306030616;2647.099986004759;2673.9465210695794;4266.7226630269015;4371.628411585011;4411.4044603978455;4413.757243351614;4424.867253982382;4338.305871060631;4425.358323043157;4438.644908407327;4450.3102019187;4464.5981861632445;4039.7374170678813;4074.653654439376;4089.89775255618;4110.342345224764;4129.896752581194;4144.523379811315;4173.874783756492;4205.831766729327;4239.491261048678;4255.723377980436;3957.2679054375035;4036.616521430459;4038.6365227129404;4151.730137541081;4170.291050521403;4047.1905618876344;4053.4527838741687;4056.71602987791;4057.8376864925367;4068.572799856002;4040.2323558523785;4040.9595904040875;4041.3937909313545;4052.3921411788174;4080.6735461163034;4360.760158191299;4385.166818304512;4389.692721509496;4440.689151759379;4443.133588950156;4695.5069717679835;4698.6241100712205;4701.083288758693;4711.458182309044;4713.552212539803;4459.732416055014;4732.9763351183365;4739.597134243593;4762.78567464465;4831.05794370098;4446.933296000562;4448.6885917985755;4449.199144154083;4451.679710058363;4466.798994045275;4869.440014398318;4881.902361952741;4882.072406242803;4883.121038213156;4922.753862306942;4525.909481810345;4602.470715867651;4668.883277918079;4681;4715;4696.225122854759;4701.224297990793;4713.34013238147;4721.716696998191;4765.69023013503;4650.627949764078;4667.299905014207;4669.41632295963;4673.088747694167;4716.787744551503;4494.640428765756;4574.359589657451;4617.168909596305;4649.418822647169;4673.6728429009645;3931.6461518463475;3945.704072194597;3949.6445319921345;3987.8205480753436;3992.9201415972097;3408.6080100788727;3481.1993241554583;3487.7907325560545;3495.5106285120105;3539.150603855056;4045.4134150548593;4097.323941549611;4136.172765446922;4158;4164.479440069991;4639.396878405786;4667.253239481734;4675.649326300541;4689.273162659793;4725.621950243973;3990.3615421532418;4089.7341672791767;4095.52901416335;4107.568705285902;4116.115035267432;4204.26425375558;4233.894152646209;4234.301340278819;4271.743695378287;4273.273543497613;4499.415076040028;4521.638268938543;4531;4552.1806074906835;4561.7262964222255;4601.67788254819;4645.74448405341;4737.218358970869;4740.265258884879;4740.739259340769;4489.147062058199;4490.146872094291;4495.348174514743;4517.09658068381;4528.954710452985;4620.099080679235;4636.258198688329;4639.86080417588;4641.6518761092375;4676.298555216745;4566.429196350457;4663.766811659336;4699.624030077517;4702.882427939192;4704.3649107370065;4580.450345958507;4610.216263235325;4625.699329543569;4630.490646028867;4664.766761661971;4629.768511574341;4634.698744581591;4636.721796692209;4656.41794775653;4676.976615116902;4323.762193079411;4427.269500532376;4539.614132798617;4551.749653769075;4582.19811532987;4624.699394539344;4635.351050852816;4649.930251046169;4657.953420465752;4687.1563118637605;4535.682502224812;4536.432945881765;4538.591526762475;4571.748553829571;4574.954250457586 04:50:00 INFO - PROCESS | 23252 | |1;ext.html;469.812075169932;470.2170885475683;525.9132243179876;527.9920801187981;531.3835950297654;23850.761492385092;24198.87900560497;24208.878955605218;24279.514409711795;30802.38395232094;33072;33592.328153436916;33600.49599256013;33603.66396336036;33630.66369336306;7340.0824896888025;7565.583892885889;7566.962165189167;7569.545827250383;7570.962145189266;7367.115946086477;7476.663550140257;7479.850402991937;7481.438892083115;7482.214367491417;7451.403887688972;7508.587027713501;7513;7516.736914208004;7674.347680447168;7584.65869035892;7661.578613176273;7667.961660191691;7668.961655191744;7682.0781506219055;7578.317951384347;7711.460197786158;7716.2669546393;7716.305532502046;7716.807079822993;34057.48913766295;34145.487817682755;34309;34544.6545534544;34617.48073778895;2597.2208337498864;2638.1557901471538;2655.800814938868;2688.6101515280175;2712.742289482516;26793.330166745793;27131.864340678367;27151.185464436097;27862.164135075982;27899.442011159663;3319.68462996015;3349.966500335014;3431.365197438482;3477.1654802847133;3516.7186625069935;202565;203285;203855;204266;205277;34237.31525369479;35398.823005884806;46004;46406;46422.30366544505;30727.23181920425;30795.38409231803;30998.22504437362;30999.225019374244;31001.534976975363;11121;11189.216754827085;11255.155863310285;11258.099352051817;11259.943700281447;8927.285817134614;8963.372563920462;8972.237359824358;8977;9023.81952360949;11704.941475292739;11980.940095299467;12012.579559715368;12018.939905300418;12208.816867746991;5032.370953630796;5159.1229490986625;5171.612129090333;5200.92198617021;5233.084210263189;765.8927750114989;820.1060843680298;823.2014945502852;888.5335199020436;925.7132585705874;24542.141025064037;24576.385590360027;25058.498830023298;25178.37054073663;25216.873915630305;859.1880672764178;936.2884208001967;1007.9798404031878;1027.7482016905906;1030.0369154840248;12778.61664150077;12932;13115.868841311465;13129.34353282332;13240.53658121961;256517;258297;260705;261109;261626;40414.191716165515;41031;41079;41125.177496449905;41162;1078.4823284823328;1080.0819303591884;1082.6481393547128;1085.853409789684;1106.601623415586;23670.289891303288;24430.551130933873;24460.143894963592;24565.26304210805;24658.876705616356;36315.81842090773;36572;36600.45099323565;36666.51668091527;36993.26013479661;235194;239438;241927;242389;242598;23354.64968025515;23794.40513987164;23992.64011039801;27655.861720691268;28004;26056;37664;38138.61861381351;38195.42706859455;38632.80683596564;29062.273443163245;29105.41789164247;29632.111036668935;29833;30124.54813177848;29288.56067159037;29401.264968375963;29924.401511969205;30056.098317050524;30363.696363036972;29483.410331792817;29501;29766;29913.551296730133;30066;26668;27089.593656095567;27101.457970840867;27190.592141117504;27474.725252747216;19752.111154998347;20147.194112235346;20150.69773953421;20217.393478195678;20256.493587660425 04:50:00 INFO - PROCESS | 23252 | |2;jquery.html;290.726716886127;292.65905220418216;313.36230770382275;319.3835896719331;322.56936989119527;10843.240973131875;14487.203203823785;14946.476873309437;14981.77527337088;15501.612459688486;13636.727265454685;14064.929675351634;14127.223002734845;14362;14367.281635918214;4760.143174228638;4929.926051109236;4930.630202734791;4949.529794669518;4965.354503914504;3511.525943997566;5472.288602481672;5685.943140568604;5686.800961966332;5691.544676425876;5621.325440947092;5626.071698169818;5626.240457538242;5634.4928956393915;5638.887222255573;5477.370102438211;5511.889762204753;5590.776368945238;5611.775528978836;5622.746976386073;4829.589484893788;4865.683730557503;4872.342233798463;4873.853784386474;4875.07373599015;17477.475675729747;17682.469525914243;18293.7255941161;18320.633587328313;18342;1944.8346890514324;1988.7016947457996;2083.479130217446;2110.9472263193543;2454.7667971542674;11865.52537898483;11882.40587970598;12060.758784824342;12376.257424554555;12595.118341716083;1770.0795586295183;1770.7432422298696;1777.6089260362828;1780.7863056433312;1827.5613852675394;50694.239586406235;51538.22692659613;51678;51822.48177518252;52421;8075.878861817077;8690.522021288889;8735.65057397697;8947.105289471001;9112.453252804853;10733.409662468639;11166.218364714554;11176.217664763552;11183.944080279547;11190;6279.215098112736;6335.176427064452;6406.519511036691;6450.709718062699;6534.085228068075;6163.7842675506145;6188.2883468400805;6268.905966410507;6301.4328710416285;6329.620222786648;5241.187615919539;5299.33758280215;5383.111786555174;5454.4545545445135;5593.804216852472;1577.2113943028485;1578.629022179787;1584.4612831637298;1592.840715928398;1599.960000999961;366.3972764801939;373.6506366547287;376.8756310417556;844.1600607395558;884.4781578868499;9180.219681327162;9253.629854805868;9350.812983740287;9355.719328420158;9587.280953928483;385.68373933374926;388.2681146039736;390.6113417149954;391.81584655212004;401.10953682824083;5109.923351149736;5145.536901678867;5158.664686795346;5189.558887494605;5249.133892907704;350387;354487;356599;363361;372431;66702.66648666725;66991;67452.32547674558;67885;69318.30681693219;842.6839935024366;887.4852585500523;889.4529864133641;890.1899271662755;892.2237653241722;12854;13115.344232788513;13612.931935340655;13699.520516782264;13788.103773254707;21608;29819.403611927206;30070.3985920276;30396;30769.538456923612;33447.83276083604;33696.49455258124;36413.817930910176;36517.63482365249;37177.4423383644;6584.604923704593;6811.489138314547;6850.6574671267235;6968.895466568107;7148.857022859618;8867.556622168995;10574.41840698769;10750.13998880072;10803.243772935819;11235.606753763579;8870.689525866565;9148.725538233864;9326.347155699308;9919.305648604528;10168.745781355525;8955.462672239686;9599.376040557341;9661;9664.130228279488;9722.416655000723;9508.429494230368;9910.405375677483;9963.651272205438;10162.136218421221;10277;6895.862082758216;7112.182099058675;7138.321859423347;7232.566046037255;7355.7057717690695;9587.904120958701;10129.290949633454;10200.897991019994;10344.689659310232;10483.52824122901 04:50:00 INFO - PROCESS | 23252 | |3;mootools.html;1132.3771925441006;1137.7041969088036;1164.5865717670222;1174.049020293562;1460.5764328344774;6391.616503009823;6490.286068532463;6513.218413790351;6526.902096468557;6533.738650453988;6272.84317892053;6430.646314452703;6436.452901503378;6449.709763060662;6462.870742585145;1675.723505621571;1899.1928430417086;1923.5864289177823;1937.8740381875205;1955.1690531524046;1926.0369815092454;1930.3629802165322;1935.2452543508043;1935.4870959195825;1935.709643553471;1900.3443811884877;1913.0530387458227;1984.3848406993807;1984.5534754680225;1985.7815640279557;1916.2430839818333;1944.0474167657817;1956.5597740508415;1959.255482916497;1959.5297128689083;1918.539550507882;1929.2668785861424;1930.7779605345283;1930.9710354344695;1932.5168707823045;6715.328467153295;6752.8311792205095;6766.951122576009;6769.05233267343;6780.593164410151;3642.307961487309;3731.552213734369;3753.230587729509;3759.154190307159;3762.1347090169415;2492.538880307131;2550.1839411388364;2577.574700174469;2579.1230981466206;2590.792736581088;837.660747397305;854.175720429782;859.5444414460346;864.3733293362325;899.8245342158282;9097.226735727405;9102.453852768855;9106.499142547158;9112.726618201465;9116.635334586608;3308.9007329780147;3515.191505953594;3598.082488965297;3598.6581274778855;3601.2977469393218;7799.649015794303;7800.687972481037;7818.14000459949;7833.882491762628;7838.451308408471;3285.5071739239306;3738.12154143776;3768.717346199046;3774.9811250944117;3779.603141670085;3291.736661067109;3333.300006998509;3335.8999230023137;3352.4468462703867;3364.9327013459592;3058.4341896749174;3090.799098058619;3164.177313898403;3165.635951865519;3167.0657156138996;930.6277489004452;933.6825479337058;934.5981228071859;938.2259635800492;951.6811868024151;985.963984372269;1003.6236411345745;1009.1674368645896;1013.6502906497246;1022.8414595737672;6295.276043254993;6407.7757278495965;6410.903836442457;6423.293437721847;6444.7744328948265;377.5714563969859;379.1696185354121;382.13827818269624;384.5212710175849;386.1466159786846;4876.609871210295;4914.213725803854;4918.8770280743265;4950.603951683928;4955.82654607087;7512.774616761506;7687.846243075219;7741.7677469676;7949.3243074339325;8284.8343033139;7596.620168991528;7618.542887426772;7638.579878106758;7651.426143039294;7652;6281.591696539619;6302.054691796267;6462.547621666532;6468.8059358219325;6471.417572418411;5978.133170690138;6010.909836352371;6041.305249896142;6056.606320589148;6056.848578785565;7112.253213412724;7258.963705181441;7265.019222405119;7380.151282602569;7408.222136675571;7406.925930740624;7533.434992375484;7602.657880395506;7604.733834315773;7615.961920190363;4886.096072226649;5471.261379713687;5676.489115979582;5767.884642307215;5772.884542309046;6030.517558595389;6061.121137435135;6068.726907289094;6088.330283668704;6100.8779824404155;5546.306711661043;5558.638688485235;5586.469285417878;5690.687012214368;5723.141528770551;5362.785488580413;5402.972985135049;5478.780848766164;5507.339119305709;5510.201020852034;5924;5967.552433567413;5974.880502390015;5984.222051133324;5987.520998320211;5458;5555.944440555542;5557.472040156179;5561;5571.66570005801;5491.176323551499;5494;5504.22940788298;5507.862303442285;5513.889722205614 04:50:00 INFO - PROCESS | 23252 | |4;prototype.html;268.95562232231686;276.095786299868;282.01717016198546;283.92392831169866;284.77929604556476;5191.818286359978;5196.974015129919;5209.166533354664;5213.218017297408;5214.713190774506;5031.52200540948;5151.047056294588;5151.562117220032;5166.354205724285;5170;4022.195560887827;4026.879193624196;4048.7165898387125;4051.4530538377385;4056.127932494513;4038.2125485530332;4047.7368971016936;4049.0889549851195;4049.9190016199805;4057.2291264659766;3998;4008.458858054169;4013.5585085640555;4016.6585840203616;4034.394840773878;4015.859444919443;4017.919641607181;4018.276710192179;4021.2560676274984;4031.5766844481495;3543.1319326765106;3546.8226588670723;3547.5033495310677;3547.7161827054033;3552.0409489437966;4828.927566086511;5043.621728370387;5054.064997975386;5056.393232812049;5063.594912406998;4488.551144885518;4490.57339552742;4508.301213311942;4514.187446259672;4516.638668906479;5389.703566303851;5416.458354164592;5417.4289456057695;5427.782888684448;5429.53848922842;3650.7627004244905;3670.376036073874;3701.759385639925;3702.9444558331647;3711.5175027246555;5432.266644003049;5524.917126243109;5573.136163894644;5624.859378515529;5693.060644993571;3683.778973261613;3685.3366394048794;3685.6130106338983;3691.557013158438;3756.2111956489443;3802.1825307559006;3805.5243094613174;3817.3892177251505;3826.617338266151;3828.0238539172333;4461.263891457938;4461.486929003141;4462.553744625511;4468.609294027679;4468.798904049326;5160.767765450564;5295;5295.285136506599;5295.391030031518;5396.83809485716;1304.9869501304865;1339.9196048237136;1346.0308577824146;1347.6563476313672;1347.8921686265076;870.6865528409768;874.2001069021901;895.83427065993;897.7935074932802;898.577668495819;4732.361131247238;4756.143894099096;4762;4766.428028636586;4767.189577771787;5551.2228288039705;5555.8888822224135;5556.444355564492;5557.694326812064;5558.833235002957;4749.833755818529;4752.691075080178;4753.809847606057;4761.976190119097;4763.666543341933;2954.778391620637;2998.3253767902047;2998.550217467354;2998.8050776699447;3001.714837090473;5262.789488420421;5291.735413229323;5295.470452954673;5296.894062118736;5306.548943339782;5514.531264842533;5662.745176467069;5698.287714035746;5709.628874123168;5714.828555143353;5255.76349064293;5261.500157485033;5281.049411106038;5287.180487024518;5294.100002999499;5553.944460555343;5555.30558680165;5556.527695145958;5574.693391863487;5625.887482250414;5445.047116754473;5449.836504904859;5450.1007333789485;5455.045367060828;5461.098918678374;5252.395974462986;5255.763490643007;5287.550558202442;5292.470752924677;5295.894082118413;3575.9284814304087;3644.1071937375514;3699.815009249473;3737.663610275088;3758.079270578616;5581.9162712560155;5597.496225339739;5604.439556044526;5607.186957891165;5613.607047506635;5378.19327100938;5396.703181325065;5397.865053373697;5399.217113518596;5402.540784033401;5382.381026182039;5387.784488620411;5392.544013116515;5401.081816091195;5402.135658294654;5239.7118158500125;5256.842294731164;5263.9210411844615;5265.131253343156;5266.815661451831;5255.448177941414;5411.864703382447;5430.185472179205;5432.239486471818;5444.673319600836;5243.921341179809;5256.500632439912;5263.0789611818545;5268;5276.287701160448 04:50:00 INFO - PROCESS | 23252 | |5;yui.html;609.1532769450465;622.3247776162863;628.1138170108351;629.263761399163;647.9190101237346;9442.85835712464;9500.904990950088;9509.952450237748;9767.169790567792;11845.46695398707;11204.271722338042;11254.155938304619;11259.380734059623;11293.774124517526;11356.091512678986;553.6346011632323;659.9472042236633;679.5447050476192;680.9455243580502;694.0768777525903;656.8784774816651;661.0315887225214;687.1342108942744;688.6419062087712;690.547691262224;695.8608278344326;714.6391072508376;716.8064622551908;723.9058922340089;729.4820677319083;681.7750142452978;687.7902239816854;688.2429327739471;688.3873352716087;695.8364784275691;504.9368828896388;505.0580667055951;509.36838320482707;514.4289838279507;523.5157479331604;10220.437875916821;10391.740206494822;10401.531931063044;10444.321119127233;10461.110805581535;10830.40432776197;11273.60542381021;11374.090072794239;11437.19939604228;11566.30602163873;8639.481631102153;8646;8652.394332396734;8653.480791152488;8686.826263474759;3061.418330517217;3102.829344386058;3113.828739419331;3129.9687003129907;3171.5876935998403;38749.41875871864;38853.22293554142;39066.80466597677;40621.39067913983;40815.7959210202;7979.401544884041;8277.172282771795;8332.250097491255;8374.120717324593;8387.832243355098;14874.628134296729;14894.180820055;14954.775678364833;15075.246237688072;15085.170315632746;5257.684538927677;5539.41836107211;5643.435656434323;5655.095184770417;5842.970785146132;3329.433996220648;3355.5134505497053;3440.174358154075;3441.0881116504147;3483.3381657484997;2483.217786397315;2483.5902076157595;2493.5885578879643;2519.8110141739444;2527.3428908483925;402.3060221118547;428.8434721326693;429.96345310648945;430.8944308644402;472.0723777776685;375.8891127117452;446.59359982415845;495.70010143863163;506.75422420126944;514.0567059445958;6692.899606505906;6700.128983232149;6859.588424694534;7102.112235970504;7127.681378944912;428.8884889928641;477.28883962895037;499.3558309780415;499.79508401555915;512.5003121956138;3135.6901340118893;3206.6633003534757;3208.294175281481;3263.314703912205;3338.8981636060043;44919.55080449219;47511.287330690066;48063.75968120207;48310.758446208245;48537.514624854004;41769.58230417718;42237.78881105575;42636.57363426326;42692.57307426948;42722.78638606787;38160.809195954396;38176.236475270896;38298.80850595729;38828;38832.41751373732;6353.96823015882;6361.427471527585;6511.837204069747;6528.314526974599;6651.401373876374;26607.600885987114;29089.563656544746;29849.850750746107;29974.100776976724;30573.54139687862;32031.35937281288;36695;37873;38803.61196388;39020.2195956085;8733;8863.982178552615;8869.778255543404;9236.26109911192;9269.86095208559;9572.377795443273;9731.341200165445;9905.653302134391;9933.552990115317;9982.800343993225;9000.59497322635;9013.63945442175;9337.112974267433;9369.437833729999;9564.282678798978;8525.957370213357;9452.10205030521;9668.613255469703;9927.205823534245;10000.449975251431;8208.712695055645;8621.137886211329;8829.514376709343;9265.119813617695;9480.146786789222;8411;8554.615042323236;8592.742217733477;8720.476771393736;9026.819463610822;8278.627461764114;8305.709300174465;8352.665893364197;8375.832483350421;8664.653413863374 04:50:00 INFO - PROCESS | 23252 | __end_tp_report 04:50:00 INFO - PROCESS | 23252 | __start_cc_report 04:50:00 INFO - PROCESS | 23252 | _x_x_mozilla_cycle_collect,817 04:50:00 INFO - PROCESS | 23252 | __end_cc_report 04:50:00 INFO - PROCESS | 23252 | __startTimestamp1456836600481__endTimestamp 04:50:00 INFO - PROCESS | 23252 | 04:50:00 INFO - PROCESS | 23252 | ------- Summary: start ------- 04:50:00 INFO - PROCESS | 23252 | Number of tests: 6 04:50:00 INFO - PROCESS | 23252 | 04:50:00 INFO - PROCESS | 23252 | [#0] dojo.html Cycles:165 Average:4371.61 Median:4499.42 stddev:431.41 (9.6%) stddev-sans-first:409.14 04:50:00 INFO - PROCESS | 23252 | Values: 2577.7 2639.4 2644.6 2647.1 2673.9 4266.7 4371.6 4411.4 4413.8 4424.9 4338.3 4425.4 4438.6 4450.3 4464.6 4039.7 4074.7 4089.9 4110.3 4129.9 4144.5 4173.9 4205.8 4239.5 4255.7 3957.3 4036.6 4038.6 4151.7 4170.3 4047.2 4053.5 4056.7 4057.8 4068.6 4040.2 4041.0 4041.4 4052.4 4080.7 4360.8 4385.2 4389.7 4440.7 4443.1 4695.5 4698.6 4701.1 4711.5 4713.6 4459.7 4733.0 4739.6 4762.8 4831.1 4446.9 4448.7 4449.2 4451.7 4466.8 4869.4 4881.9 4882.1 4883.1 4922.8 4525.9 4602.5 4668.9 4681.0 4715.0 4696.2 4701.2 4713.3 4721.7 4765.7 4650.6 4667.3 4669.4 4673.1 4716.8 4494.6 4574.4 4617.2 4649.4 4673.7 3931.6 3945.7 3949.6 3987.8 3992.9 3408.6 3481.2 3487.8 3495.5 3539.2 4045.4 4097.3 4136.2 4158.0 4164.5 4639.4 4667.3 4675.6 4689.3 4725.6 3990.4 4089.7 4095.5 4107.6 4116.1 4204.3 4233.9 4234.3 4271.7 4273.3 4499.4 4521.6 4531.0 4552.2 4561.7 4601.7 4645.7 4737.2 4740.3 4740.7 4489.1 4490.1 4495.3 4517.1 4529.0 4620.1 4636.3 4639.9 4641.7 4676.3 4566.4 4663.8 4699.6 4702.9 4704.4 4580.5 4610.2 4625.7 4630.5 4664.8 4629.8 4634.7 4636.7 4656.4 4677.0 4323.8 4427.3 4539.6 4551.7 4582.2 4624.7 4635.4 4649.9 4658.0 4687.2 4535.7 4536.4 4538.6 4571.7 4575.0 04:50:00 INFO - PROCESS | 23252 | 04:50:00 INFO - PROCESS | 23252 | [#1] ext.html Cycles:180 Average:36640.73 Median:30095.27 stddev:61557.27 (204.5%) stddev-sans-first:61670.05 04:50:00 INFO - PROCESS | 23252 | Values: 469.8 470.2 525.9 528.0 531.4 23850.8 24198.9 24208.9 24279.5 30802.4 33072.0 33592.3 33600.5 33603.7 33630.7 7340.1 7565.6 7567.0 7569.5 7571.0 7367.1 7476.7 7479.9 7481.4 7482.2 7451.4 7508.6 7513.0 7516.7 7674.3 7584.7 7661.6 7668.0 7669.0 7682.1 7578.3 7711.5 7716.3 7716.3 7716.8 34057.5 34145.5 34309.0 34544.7 34617.5 2597.2 2638.2 2655.8 2688.6 2712.7 26793.3 27131.9 27151.2 27862.2 27899.4 3319.7 3350.0 3431.4 3477.2 3516.7 202565.0 203285.0 203855.0 204266.0 205277.0 34237.3 35398.8 46004.0 46406.0 46422.3 30727.2 30795.4 30998.2 30999.2 31001.5 11121.0 11189.2 11255.2 11258.1 11259.9 8927.3 8963.4 8972.2 8977.0 9023.8 11704.9 11980.9 12012.6 12018.9 12208.8 5032.4 5159.1 5171.6 5200.9 5233.1 765.9 820.1 823.2 888.5 925.7 24542.1 24576.4 25058.5 25178.4 25216.9 859.2 936.3 1008.0 1027.7 1030.0 12778.6 12932.0 13115.9 13129.3 13240.5 256517.0 258297.0 260705.0 261109.0 261626.0 40414.2 41031.0 41079.0 41125.2 41162.0 1078.5 1080.1 1082.6 1085.9 1106.6 23670.3 24430.6 24460.1 24565.3 24658.9 36315.8 36572.0 36600.5 36666.5 36993.3 235194.0 239438.0 241927.0 242389.0 242598.0 23354.6 23794.4 23992.6 27655.9 28004.0 26056.0 37664.0 38138.6 38195.4 38632.8 29062.3 29105.4 29632.1 29833.0 30124.5 29288.6 29401.3 29924.4 30056.1 30363.7 29483.4 29501.0 29766.0 29913.6 30066.0 26668.0 27089.6 27101.5 27190.6 27474.7 19752.1 20147.2 20150.7 20217.4 20256.5 04:50:00 INFO - PROCESS | 23252 | 04:50:00 INFO - PROCESS | 23252 | [#2] jquery.html Cycles:180 Average:21232.08 Median:4902.50 stddev:58992.43 (1203.3%) stddev-sans-first:59136.96 04:50:00 INFO - PROCESS | 23252 | Values: 290.7 292.7 313.4 319.4 322.6 10843.2 14487.2 14946.5 14981.8 15501.6 13636.7 14064.9 14127.2 14362.0 14367.3 4760.1 4929.9 4930.6 4949.5 4965.4 3511.5 5472.3 5685.9 5686.8 5691.5 5621.3 5626.1 5626.2 5634.5 5638.9 5477.4 5511.9 5590.8 5611.8 5622.7 4829.6 4865.7 4872.3 4873.9 4875.1 17477.5 17682.5 18293.7 18320.6 18342.0 1944.8 1988.7 2083.5 2110.9 2454.8 11865.5 11882.4 12060.8 12376.3 12595.1 1770.1 1770.7 1777.6 1780.8 1827.6 50694.2 51538.2 51678.0 51822.5 52421.0 8075.9 8690.5 8735.7 8947.1 9112.5 10733.4 11166.2 11176.2 11183.9 11190.0 6279.2 6335.2 6406.5 6450.7 6534.1 6163.8 6188.3 6268.9 6301.4 6329.6 5241.2 5299.3 5383.1 5454.5 5593.8 1577.2 1578.6 1584.5 1592.8 1600.0 366.4 373.7 376.9 844.2 884.5 9180.2 9253.6 9350.8 9355.7 9587.3 385.7 388.3 390.6 391.8 401.1 5109.9 5145.5 5158.7 5189.6 5249.1 350387.0 354487.0 356599.0 363361.0 372431.0 66702.7 66991.0 67452.3 67885.0 69318.3 842.7 887.5 889.5 890.2 892.2 12854.0 13115.3 13612.9 13699.5 13788.1 21608.0 29819.4 30070.4 30396.0 30769.5 33447.8 33696.5 36413.8 36517.6 37177.4 6584.6 6811.5 6850.7 6968.9 7148.9 8867.6 10574.4 10750.1 10803.2 11235.6 8870.7 9148.7 9326.3 9919.3 10168.7 8955.5 9599.4 9661.0 9664.1 9722.4 9508.4 9910.4 9963.7 10162.1 10277.0 6895.9 7112.2 7138.3 7232.6 7355.7 9587.9 10129.3 10200.9 10344.7 10483.5 04:50:00 INFO - PROCESS | 23252 | 04:50:00 INFO - PROCESS | 23252 | [#3] mootools.html Cycles:180 Average:4563.70 Median:5559.82 stddev:2427.30 (43.7%) stddev-sans-first:2420.40 04:50:00 INFO - PROCESS | 23252 | Values: 1132.4 1137.7 1164.6 1174.0 1460.6 6391.6 6490.3 6513.2 6526.9 6533.7 6272.8 6430.6 6436.5 6449.7 6462.9 1675.7 1899.2 1923.6 1937.9 1955.2 1926.0 1930.4 1935.2 1935.5 1935.7 1900.3 1913.1 1984.4 1984.6 1985.8 1916.2 1944.0 1956.6 1959.3 1959.5 1918.5 1929.3 1930.8 1931.0 1932.5 6715.3 6752.8 6767.0 6769.1 6780.6 3642.3 3731.6 3753.2 3759.2 3762.1 2492.5 2550.2 2577.6 2579.1 2590.8 837.7 854.2 859.5 864.4 899.8 9097.2 9102.5 9106.5 9112.7 9116.6 3308.9 3515.2 3598.1 3598.7 3601.3 7799.6 7800.7 7818.1 7833.9 7838.5 3285.5 3738.1 3768.7 3775.0 3779.6 3291.7 3333.3 3335.9 3352.4 3364.9 3058.4 3090.8 3164.2 3165.6 3167.1 930.6 933.7 934.6 938.2 951.7 986.0 1003.6 1009.2 1013.7 1022.8 6295.3 6407.8 6410.9 6423.3 6444.8 377.6 379.2 382.1 384.5 386.1 4876.6 4914.2 4918.9 4950.6 4955.8 7512.8 7687.8 7741.8 7949.3 8284.8 7596.6 7618.5 7638.6 7651.4 7652.0 6281.6 6302.1 6462.5 6468.8 6471.4 5978.1 6010.9 6041.3 6056.6 6056.8 7112.3 7259.0 7265.0 7380.2 7408.2 7406.9 7533.4 7602.7 7604.7 7616.0 4886.1 5471.3 5676.5 5767.9 5772.9 6030.5 6061.1 6068.7 6088.3 6100.9 5546.3 5558.6 5586.5 5690.7 5723.1 5362.8 5403.0 5478.8 5507.3 5510.2 5924.0 5967.6 5974.9 5984.2 5987.5 5458.0 5555.9 5557.5 5561.0 5571.7 5491.2 5494.0 5504.2 5507.9 5513.9 04:50:00 INFO - PROCESS | 23252 | 04:50:00 INFO - PROCESS | 23252 | [#4] prototype.html Cycles:180 Average:4459.64 Median:5180.91 stddev:1319.91 (25.5%) stddev-sans-first:1285.59 04:50:00 INFO - PROCESS | 23252 | Values: 269.0 276.1 282.0 283.9 284.8 5191.8 5197.0 5209.2 5213.2 5214.7 5031.5 5151.0 5151.6 5166.4 5170.0 4022.2 4026.9 4048.7 4051.5 4056.1 4038.2 4047.7 4049.1 4049.9 4057.2 3998.0 4008.5 4013.6 4016.7 4034.4 4015.9 4017.9 4018.3 4021.3 4031.6 3543.1 3546.8 3547.5 3547.7 3552.0 4828.9 5043.6 5054.1 5056.4 5063.6 4488.6 4490.6 4508.3 4514.2 4516.6 5389.7 5416.5 5417.4 5427.8 5429.5 3650.8 3670.4 3701.8 3702.9 3711.5 5432.3 5524.9 5573.1 5624.9 5693.1 3683.8 3685.3 3685.6 3691.6 3756.2 3802.2 3805.5 3817.4 3826.6 3828.0 4461.3 4461.5 4462.6 4468.6 4468.8 5160.8 5295.0 5295.3 5295.4 5396.8 1305.0 1339.9 1346.0 1347.7 1347.9 870.7 874.2 895.8 897.8 898.6 4732.4 4756.1 4762.0 4766.4 4767.2 5551.2 5555.9 5556.4 5557.7 5558.8 4749.8 4752.7 4753.8 4762.0 4763.7 2954.8 2998.3 2998.6 2998.8 3001.7 5262.8 5291.7 5295.5 5296.9 5306.5 5514.5 5662.7 5698.3 5709.6 5714.8 5255.8 5261.5 5281.0 5287.2 5294.1 5553.9 5555.3 5556.5 5574.7 5625.9 5445.0 5449.8 5450.1 5455.0 5461.1 5252.4 5255.8 5287.6 5292.5 5295.9 3575.9 3644.1 3699.8 3737.7 3758.1 5581.9 5597.5 5604.4 5607.2 5613.6 5378.2 5396.7 5397.9 5399.2 5402.5 5382.4 5387.8 5392.5 5401.1 5402.1 5239.7 5256.8 5263.9 5265.1 5266.8 5255.4 5411.9 5430.2 5432.2 5444.7 5243.9 5256.5 5263.1 5268.0 5276.3 04:50:00 INFO - PROCESS | 23252 | 04:50:00 INFO - PROCESS | 23252 | [#5] yui.html Cycles:180 Average:11359.58 Median:518.97 stddev:13216.30 (2546.6%) stddev-sans-first:13228.72 04:50:00 INFO - PROCESS | 23252 | Values: 609.2 622.3 628.1 629.3 647.9 9442.9 9500.9 9510.0 9767.2 11845.5 11204.3 11254.2 11259.4 11293.8 11356.1 553.6 659.9 679.5 680.9 694.1 656.9 661.0 687.1 688.6 690.5 695.9 714.6 716.8 723.9 729.5 681.8 687.8 688.2 688.4 695.8 504.9 505.1 509.4 514.4 523.5 10220.4 10391.7 10401.5 10444.3 10461.1 10830.4 11273.6 11374.1 11437.2 11566.3 8639.5 8646.0 8652.4 8653.5 8686.8 3061.4 3102.8 3113.8 3130.0 3171.6 38749.4 38853.2 39066.8 40621.4 40815.8 7979.4 8277.2 8332.3 8374.1 8387.8 14874.6 14894.2 14954.8 15075.2 15085.2 5257.7 5539.4 5643.4 5655.1 5843.0 3329.4 3355.5 3440.2 3441.1 3483.3 2483.2 2483.6 2493.6 2519.8 2527.3 402.3 428.8 430.0 430.9 472.1 375.9 446.6 495.7 506.8 514.1 6692.9 6700.1 6859.6 7102.1 7127.7 428.9 477.3 499.4 499.8 512.5 3135.7 3206.7 3208.3 3263.3 3338.9 44919.6 47511.3 48063.8 48310.8 48537.5 41769.6 42237.8 42636.6 42692.6 42722.8 38160.8 38176.2 38298.8 38828.0 38832.4 6354.0 6361.4 6511.8 6528.3 6651.4 26607.6 29089.6 29849.9 29974.1 30573.5 32031.4 36695.0 37873.0 38803.6 39020.2 8733.0 8864.0 8869.8 9236.3 9269.9 9572.4 9731.3 9905.7 9933.6 9982.8 9000.6 9013.6 9337.1 9369.4 9564.3 8526.0 9452.1 9668.6 9927.2 10000.4 8208.7 8621.1 8829.5 9265.1 9480.1 8411.0 8554.6 8592.7 8720.5 9026.8 8278.6 8305.7 8352.7 8375.8 8664.7 04:50:00 INFO - PROCESS | 23252 | -------- Summary: end -------- 04:50:00 INFO - PROCESS | 23252 | 04:50:00 INFO - PROCESS | 23252 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:00 INFO - PROCESS | 23252 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:00 INFO - PROCESS | 23252 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:00 INFO - PROCESS | 23252 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:00 INFO - PROCESS | 23252 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:01 INFO - TEST-INFO | 23252: exit 0 04:50:01 INFO - TEST-OK | dromaeo_css | took 1116143ms 04:50:01 INFO - TEST-START | kraken 04:50:01 INFO - operating with platform_type : linux_ 04:50:01 INFO - Initialising browser for kraken test... 04:50:01 INFO - TEST-INFO | started process 23430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMVrk2B/profile http://localhost:44514/getInfo.html) 04:50:05 INFO - PROCESS | 23430 | __metrics Screen width/height:1600/1200 04:50:05 INFO - PROCESS | 23430 | colorDepth:24 04:50:05 INFO - PROCESS | 23430 | Browser inner width/height: 1024/697 04:50:05 INFO - PROCESS | 23430 | __metrics 04:50:06 INFO - PROCESS | 23430 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:06 INFO - PROCESS | 23430 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:06 INFO - PROCESS | 23430 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:06 INFO - PROCESS | 23430 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:06 INFO - PROCESS | 23430 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:06 INFO - PROCESS | 23430 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:06 INFO - PROCESS | 23430 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:06 INFO - PROCESS | 23430 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:50:07 INFO - TEST-INFO | 23430: exit 0 04:50:07 INFO - Browser initialized. 04:50:07 INFO - Running cycle 1/1 for kraken test... 04:50:07 INFO - TEST-INFO | started process 23514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMVrk2B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:19 INFO - PROCESS | 23514 | RSS: Main: 153808896 04:50:19 INFO - PROCESS | 23514 | 04:50:21 INFO - PROCESS | 23514 | Cycle 1(1): loaded http://localhost:44514/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44514/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:22 INFO - PROCESS | 23514 | RSS: Main: 197021696 04:50:22 INFO - PROCESS | 23514 | 04:50:25 INFO - PROCESS | 23514 | Cycle 1(1): loaded http://localhost:44514/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44514/tests/kraken/driver.html?testName=audio-dft) 04:50:25 INFO - PROCESS | 23514 | RSS: Main: 186314752 04:50:25 INFO - PROCESS | 23514 | 04:50:28 INFO - PROCESS | 23514 | Cycle 1(1): loaded http://localhost:44514/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44514/tests/kraken/driver.html?testName=audio-fft) 04:50:29 INFO - PROCESS | 23514 | RSS: Main: 171188224 04:50:29 INFO - PROCESS | 23514 | 04:50:31 INFO - PROCESS | 23514 | Cycle 1(1): loaded http://localhost:44514/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44514/tests/kraken/driver.html?testName=audio-oscillator) 04:50:32 INFO - PROCESS | 23514 | RSS: Main: 174161920 04:50:32 INFO - PROCESS | 23514 | 04:50:34 INFO - PROCESS | 23514 | Cycle 1(1): loaded http://localhost:44514/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44514/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:34 INFO - PROCESS | 23514 | RSS: Main: 174882816 04:50:34 INFO - PROCESS | 23514 | 04:50:38 INFO - PROCESS | 23514 | Cycle 1(1): loaded http://localhost:44514/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44514/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:38 INFO - PROCESS | 23514 | RSS: Main: 176807936 04:50:38 INFO - PROCESS | 23514 | 04:50:42 INFO - PROCESS | 23514 | Cycle 1(1): loaded http://localhost:44514/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44514/tests/kraken/driver.html?testName=imaging-desaturate) 04:50:42 INFO - PROCESS | 23514 | RSS: Main: 176029696 04:50:42 INFO - PROCESS | 23514 | 04:50:45 INFO - PROCESS | 23514 | Cycle 1(1): loaded http://localhost:44514/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44514/tests/kraken/driver.html?testName=json-parse-financial) 04:50:46 INFO - PROCESS | 23514 | RSS: Main: 176021504 04:50:46 INFO - PROCESS | 23514 | 04:50:47 INFO - PROCESS | 23514 | Cycle 1(1): loaded http://localhost:44514/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44514/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:50:48 INFO - PROCESS | 23514 | RSS: Main: 189095936 04:50:48 INFO - PROCESS | 23514 | 04:50:50 INFO - PROCESS | 23514 | Cycle 1(1): loaded http://localhost:44514/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44514/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:50:50 INFO - PROCESS | 23514 | RSS: Main: 184741888 04:50:50 INFO - PROCESS | 23514 | 04:50:53 INFO - PROCESS | 23514 | Cycle 1(1): loaded http://localhost:44514/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44514/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:50:53 INFO - PROCESS | 23514 | RSS: Main: 195493888 04:50:53 INFO - PROCESS | 23514 | 04:50:56 INFO - PROCESS | 23514 | Cycle 1(1): loaded http://localhost:44514/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44514/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:50:56 INFO - PROCESS | 23514 | RSS: Main: 202518528 04:50:56 INFO - PROCESS | 23514 | 04:50:59 INFO - PROCESS | 23514 | Cycle 1(1): loaded http://localhost:44514/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44514/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:00 INFO - PROCESS | 23514 | RSS: Main: 199569408 04:51:00 INFO - PROCESS | 23514 | 04:51:01 INFO - PROCESS | 23514 | Cycle 1(1): loaded http://localhost:44514/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44514/tests/kraken/driver.html?testName=ai-astar) 04:51:02 INFO - PROCESS | 23514 | RSS: Main: 260415488 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | __start_tp_report 04:51:02 INFO - PROCESS | 23514 | _x_x_mozilla_page_load 04:51:02 INFO - PROCESS | 23514 | _x_x_mozilla_page_load_details 04:51:02 INFO - PROCESS | 23514 | |i|pagename|runs| 04:51:02 INFO - PROCESS | 23514 | |0;ai-astar;115;114;109;113;114;114;103;114;113;113 04:51:02 INFO - PROCESS | 23514 | |1;audio-beat-detection;155;136;158;178;135;164;163;134;175;134 04:51:02 INFO - PROCESS | 23514 | |2;audio-dft;160;162;167;161;161;162;169;162;160;162 04:51:02 INFO - PROCESS | 23514 | |3;audio-fft;74;74;105;97;74;74;74;110;96;73 04:51:02 INFO - PROCESS | 23514 | |4;audio-oscillator;96;96;137;96;95;95;149;96;95;144 04:51:02 INFO - PROCESS | 23514 | |5;imaging-gaussian-blur;117;118;117;118;117;117;116;117;117;117 04:51:02 INFO - PROCESS | 23514 | |6;imaging-darkroom;147;147;146;146;147;146;147;146;146;147 04:51:02 INFO - PROCESS | 23514 | |7;imaging-desaturate;95;95;95;96;96;96;96;96;95;95 04:51:02 INFO - PROCESS | 23514 | |8;json-parse-financial;76;67;68;68;68;68;70;76;67;67 04:51:02 INFO - PROCESS | 23514 | |9;json-stringify-tinderbox;70;70;72;71;71;71;71;71;72;72 04:51:02 INFO - PROCESS | 23514 | |10;stanford-crypto-aes;86;88;93;84;85;84;92;84;83;84 04:51:02 INFO - PROCESS | 23514 | |11;stanford-crypto-ccm;137;127;123;121;126;123;136;120;130;120 04:51:02 INFO - PROCESS | 23514 | |12;stanford-crypto-pbkdf2;151;148;151;141;148;149;149;148;148;148 04:51:02 INFO - PROCESS | 23514 | |13;stanford-crypto-sha256-iterative;71;70;74;69;69;70;69;73;69;70 04:51:02 INFO - PROCESS | 23514 | __end_tp_report 04:51:02 INFO - PROCESS | 23514 | __start_cc_report 04:51:02 INFO - PROCESS | 23514 | _x_x_mozilla_cycle_collect,1175 04:51:02 INFO - PROCESS | 23514 | __end_cc_report 04:51:02 INFO - PROCESS | 23514 | __startTimestamp1456836662100__endTimestamp 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | ------- Summary: start ------- 04:51:02 INFO - PROCESS | 23514 | Number of tests: 14 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | [#0] ai-astar Cycles:10 Average:112.20 Median:114.00 stddev:3.61 (3.2%) stddev-sans-first:3.69 04:51:02 INFO - PROCESS | 23514 | Values: 115.0 114.0 109.0 113.0 114.0 114.0 103.0 114.0 113.0 113.0 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:160.50 stddev:17.30 (10.8%) stddev-sans-first:18.34 04:51:02 INFO - PROCESS | 23514 | Values: 155.0 136.0 158.0 178.0 135.0 164.0 163.0 134.0 175.0 134.0 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:2.99 (1.8%) stddev-sans-first:3.02 04:51:02 INFO - PROCESS | 23514 | Values: 160.0 162.0 167.0 161.0 161.0 162.0 169.0 162.0 160.0 162.0 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | [#3] audio-fft Cycles:10 Average:85.10 Median:74.00 stddev:15.05 (20.3%) stddev-sans-first:15.42 04:51:02 INFO - PROCESS | 23514 | Values: 74.0 74.0 105.0 97.0 74.0 74.0 74.0 110.0 96.0 73.0 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:95.50 stddev:23.25 (24.3%) stddev-sans-first:24.11 04:51:02 INFO - PROCESS | 23514 | Values: 96.0 96.0 137.0 96.0 95.0 95.0 149.0 96.0 95.0 144.0 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:51:02 INFO - PROCESS | 23514 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 116.0 117.0 117.0 117.0 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:51:02 INFO - PROCESS | 23514 | Values: 147.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:51:02 INFO - PROCESS | 23514 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | [#8] json-parse-financial Cycles:10 Average:69.50 Median:68.00 stddev:3.54 (5.2%) stddev-sans-first:2.86 04:51:02 INFO - PROCESS | 23514 | Values: 76.0 67.0 68.0 68.0 68.0 68.0 70.0 76.0 67.0 67.0 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.00 stddev:0.74 (1.0%) stddev-sans-first:0.67 04:51:02 INFO - PROCESS | 23514 | Values: 70.0 70.0 72.0 71.0 71.0 71.0 71.0 71.0 72.0 72.0 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:85.50 stddev:3.56 (4.2%) stddev-sans-first:3.77 04:51:02 INFO - PROCESS | 23514 | Values: 86.0 88.0 93.0 84.0 85.0 84.0 92.0 84.0 83.0 84.0 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:126.50 stddev:6.25 (4.9%) stddev-sans-first:5.30 04:51:02 INFO - PROCESS | 23514 | Values: 137.0 127.0 123.0 121.0 126.0 123.0 136.0 120.0 130.0 120.0 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:148.50 stddev:2.77 (1.9%) stddev-sans-first:2.73 04:51:02 INFO - PROCESS | 23514 | Values: 151.0 148.0 151.0 141.0 148.0 149.0 149.0 148.0 148.0 148.0 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:1.78 (2.5%) stddev-sans-first:1.87 04:51:02 INFO - PROCESS | 23514 | Values: 71.0 70.0 74.0 69.0 69.0 70.0 69.0 73.0 69.0 70.0 04:51:02 INFO - PROCESS | 23514 | -------- Summary: end -------- 04:51:02 INFO - PROCESS | 23514 | 04:51:02 INFO - PROCESS | 23514 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:51:02 INFO - PROCESS | 23514 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:51:02 INFO - PROCESS | 23514 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:51:02 INFO - PROCESS | 23514 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:51:02 INFO - PROCESS | 23514 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:51:03 INFO - TEST-INFO | 23514: exit 0 04:51:03 INFO - TEST-OK | kraken | took 61810ms 04:51:03 INFO - SUITE-END | took 1177s 04:51:03 INFO - Completed test suite (00:19:38) 04:51:03 INFO - Working with test: dromaeo_css 04:51:03 INFO - Generating results file: dromaeo_css 04:51:03 INFO - Working with test: kraken 04:51:03 INFO - Generating results file: kraken 04:51:03 INFO - javascript benchmark 04:51:03 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:51:03 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:51:03 INFO - process_Request line: dromaeo_css 5707.42 graph.html#tests=[[72,94,35]] 04:51:03 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:51:03 INFO - process_Request line: kraken 1553.80 graph.html#tests=[[232,94,35]] 04:51:03 INFO - RETURN: dromaeo_css: 5707.42 04:51:03 INFO - RETURN: kraken: 1553.80 04:51:03 INFO - javascript benchmark 04:51:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2577.729338419466, 2639.379745759746, 2644.6165306030616, 2647.099986004759, 2673.9465210695794, 4266.7226630269015, 4371.628411585011, 4411.4044603978455, 4413.757243351614, 4424.867253982382, 4338.305871060631, 4425.358323043157, 4438.644908407327, 4450.3102019187, 4464.5981861632445, 4039.7374170678813, 4074.653654439376, 4089.89775255618, 4110.342345224764, 4129.896752581194, 4144.523379811315, 4173.874783756492, 4205.831766729327, 4239.491261048678, 4255.723377980436, 3957.2679054375035, 4036.616521430459, 4038.6365227129404, 4151.730137541081, 4170.291050521403, 4047.1905618876344, 4053.4527838741687, 4056.71602987791, 4057.8376864925367, 4068.572799856002, 4040.2323558523785, 4040.9595904040875, 4041.3937909313545, 4052.3921411788174, 4080.6735461163034, 4360.760158191299, 4385.166818304512, 4389.692721509496, 4440.689151759379, 4443.133588950156, 4695.5069717679835, 4698.6241100712205, 4701.083288758693, 4711.458182309044, 4713.552212539803, 4459.732416055014, 4732.9763351183365, 4739.597134243593, 4762.78567464465, 4831.05794370098, 4446.933296000562, 4448.6885917985755, 4449.199144154083, 4451.679710058363, 4466.798994045275, 4869.440014398318, 4881.902361952741, 4882.072406242803, 4883.121038213156, 4922.753862306942, 4525.909481810345, 4602.470715867651, 4668.883277918079, 4681.0, 4715.0, 4696.225122854759, 4701.224297990793, 4713.34013238147, 4721.716696998191, 4765.69023013503, 4650.627949764078, 4667.299905014207, 4669.41632295963, 4673.088747694167, 4716.787744551503, 4494.640428765756, 4574.359589657451, 4617.168909596305, 4649.418822647169, 4673.6728429009645, 3931.6461518463475, 3945.704072194597, 3949.6445319921345, 3987.8205480753436, 3992.9201415972097, 3408.6080100788727, 3481.1993241554583, 3487.7907325560545, 3495.5106285120105, 3539.150603855056, 4045.4134150548593, 4097.323941549611, 4136.172765446922, 4158.0, 4164.479440069991, 4639.396878405786, 4667.253239481734, 4675.649326300541, 4689.273162659793, 4725.621950243973, 3990.3615421532418, 4089.7341672791767, 4095.52901416335, 4107.568705285902, 4116.115035267432, 4204.26425375558, 4233.894152646209, 4234.301340278819, 4271.743695378287, 4273.273543497613, 4499.415076040028, 4521.638268938543, 4531.0, 4552.1806074906835, 4561.7262964222255, 4601.67788254819, 4645.74448405341, 4737.218358970869, 4740.265258884879, 4740.739259340769, 4489.147062058199, 4490.146872094291, 4495.348174514743, 4517.09658068381, 4528.954710452985, 4620.099080679235, 4636.258198688329, 4639.86080417588, 4641.6518761092375, 4676.298555216745, 4566.429196350457, 4663.766811659336, 4699.624030077517, 4702.882427939192, 4704.3649107370065, 4580.450345958507, 4610.216263235325, 4625.699329543569, 4630.490646028867, 4664.766761661971, 4629.768511574341, 4634.698744581591, 4636.721796692209, 4656.41794775653, 4676.976615116902, 4323.762193079411, 4427.269500532376, 4539.614132798617, 4551.749653769075, 4582.19811532987, 4624.699394539344, 4635.351050852816, 4649.930251046169, 4657.953420465752, 4687.1563118637605, 4535.682502224812, 4536.432945881765, 4538.591526762475, 4571.748553829571, 4574.954250457586], "unit": "score", "name": "dojo.html", "value": 4346.469726368647}, {"lowerIsBetter": false, "replicates": [469.812075169932, 470.2170885475683, 525.9132243179876, 527.9920801187981, 531.3835950297654, 23850.761492385092, 24198.87900560497, 24208.878955605218, 24279.514409711795, 30802.38395232094, 33072.0, 33592.328153436916, 33600.49599256013, 33603.66396336036, 33630.66369336306, 7340.0824896888025, 7565.583892885889, 7566.962165189167, 7569.545827250383, 7570.962145189266, 7367.115946086477, 7476.663550140257, 7479.850402991937, 7481.438892083115, 7482.214367491417, 7451.403887688972, 7508.587027713501, 7513.0, 7516.736914208004, 7674.347680447168, 7584.65869035892, 7661.578613176273, 7667.961660191691, 7668.961655191744, 7682.0781506219055, 7578.317951384347, 7711.460197786158, 7716.2669546393, 7716.305532502046, 7716.807079822993, 34057.48913766295, 34145.487817682755, 34309.0, 34544.6545534544, 34617.48073778895, 2597.2208337498864, 2638.1557901471538, 2655.800814938868, 2688.6101515280175, 2712.742289482516, 26793.330166745793, 27131.864340678367, 27151.185464436097, 27862.164135075982, 27899.442011159663, 3319.68462996015, 3349.966500335014, 3431.365197438482, 3477.1654802847133, 3516.7186625069935, 202565.0, 203285.0, 203855.0, 204266.0, 205277.0, 34237.31525369479, 35398.823005884806, 46004.0, 46406.0, 46422.30366544505, 30727.23181920425, 30795.38409231803, 30998.22504437362, 30999.225019374244, 31001.534976975363, 11121.0, 11189.216754827085, 11255.155863310285, 11258.099352051817, 11259.943700281447, 8927.285817134614, 8963.372563920462, 8972.237359824358, 8977.0, 9023.81952360949, 11704.941475292739, 11980.940095299467, 12012.579559715368, 12018.939905300418, 12208.816867746991, 5032.370953630796, 5159.1229490986625, 5171.612129090333, 5200.92198617021, 5233.084210263189, 765.8927750114989, 820.1060843680298, 823.2014945502852, 888.5335199020436, 925.7132585705874, 24542.141025064037, 24576.385590360027, 25058.498830023298, 25178.37054073663, 25216.873915630305, 859.1880672764178, 936.2884208001967, 1007.9798404031878, 1027.7482016905906, 1030.0369154840248, 12778.61664150077, 12932.0, 13115.868841311465, 13129.34353282332, 13240.53658121961, 256517.0, 258297.0, 260705.0, 261109.0, 261626.0, 40414.191716165515, 41031.0, 41079.0, 41125.177496449905, 41162.0, 1078.4823284823328, 1080.0819303591884, 1082.6481393547128, 1085.853409789684, 1106.601623415586, 23670.289891303288, 24430.551130933873, 24460.143894963592, 24565.26304210805, 24658.876705616356, 36315.81842090773, 36572.0, 36600.45099323565, 36666.51668091527, 36993.26013479661, 235194.0, 239438.0, 241927.0, 242389.0, 242598.0, 23354.64968025515, 23794.40513987164, 23992.64011039801, 27655.861720691268, 28004.0, 26056.0, 37664.0, 38138.61861381351, 38195.42706859455, 38632.80683596564, 29062.273443163245, 29105.41789164247, 29632.111036668935, 29833.0, 30124.54813177848, 29288.56067159037, 29401.264968375963, 29924.401511969205, 30056.098317050524, 30363.696363036972, 29483.410331792817, 29501.0, 29766.0, 29913.551296730133, 30066.0, 26668.0, 27089.593656095567, 27101.457970840867, 27190.592141117504, 27474.725252747216, 19752.111154998347, 20147.194112235346, 20150.69773953421, 20217.393478195678, 20256.493587660425], "unit": "score", "name": "ext.html", "value": 14781.030061060275}, {"lowerIsBetter": false, "replicates": [290.726716886127, 292.65905220418216, 313.36230770382275, 319.3835896719331, 322.56936989119527, 10843.240973131875, 14487.203203823785, 14946.476873309437, 14981.77527337088, 15501.612459688486, 13636.727265454685, 14064.929675351634, 14127.223002734845, 14362.0, 14367.281635918214, 4760.143174228638, 4929.926051109236, 4930.630202734791, 4949.529794669518, 4965.354503914504, 3511.525943997566, 5472.288602481672, 5685.943140568604, 5686.800961966332, 5691.544676425876, 5621.325440947092, 5626.071698169818, 5626.240457538242, 5634.4928956393915, 5638.887222255573, 5477.370102438211, 5511.889762204753, 5590.776368945238, 5611.775528978836, 5622.746976386073, 4829.589484893788, 4865.683730557503, 4872.342233798463, 4873.853784386474, 4875.07373599015, 17477.475675729747, 17682.469525914243, 18293.7255941161, 18320.633587328313, 18342.0, 1944.8346890514324, 1988.7016947457996, 2083.479130217446, 2110.9472263193543, 2454.7667971542674, 11865.52537898483, 11882.40587970598, 12060.758784824342, 12376.257424554555, 12595.118341716083, 1770.0795586295183, 1770.7432422298696, 1777.6089260362828, 1780.7863056433312, 1827.5613852675394, 50694.239586406235, 51538.22692659613, 51678.0, 51822.48177518252, 52421.0, 8075.878861817077, 8690.522021288889, 8735.65057397697, 8947.105289471001, 9112.453252804853, 10733.409662468639, 11166.218364714554, 11176.217664763552, 11183.944080279547, 11190.0, 6279.215098112736, 6335.176427064452, 6406.519511036691, 6450.709718062699, 6534.085228068075, 6163.7842675506145, 6188.2883468400805, 6268.905966410507, 6301.4328710416285, 6329.620222786648, 5241.187615919539, 5299.33758280215, 5383.111786555174, 5454.4545545445135, 5593.804216852472, 1577.2113943028485, 1578.629022179787, 1584.4612831637298, 1592.840715928398, 1599.960000999961, 366.3972764801939, 373.6506366547287, 376.8756310417556, 844.1600607395558, 884.4781578868499, 9180.219681327162, 9253.629854805868, 9350.812983740287, 9355.719328420158, 9587.280953928483, 385.68373933374926, 388.2681146039736, 390.6113417149954, 391.81584655212004, 401.10953682824083, 5109.923351149736, 5145.536901678867, 5158.664686795346, 5189.558887494605, 5249.133892907704, 350387.0, 354487.0, 356599.0, 363361.0, 372431.0, 66702.66648666725, 66991.0, 67452.32547674558, 67885.0, 69318.30681693219, 842.6839935024366, 887.4852585500523, 889.4529864133641, 890.1899271662755, 892.2237653241722, 12854.0, 13115.344232788513, 13612.931935340655, 13699.520516782264, 13788.103773254707, 21608.0, 29819.403611927206, 30070.3985920276, 30396.0, 30769.538456923612, 33447.83276083604, 33696.49455258124, 36413.817930910176, 36517.63482365249, 37177.4423383644, 6584.604923704593, 6811.489138314547, 6850.6574671267235, 6968.895466568107, 7148.857022859618, 8867.556622168995, 10574.41840698769, 10750.13998880072, 10803.243772935819, 11235.606753763579, 8870.689525866565, 9148.725538233864, 9326.347155699308, 9919.305648604528, 10168.745781355525, 8955.462672239686, 9599.376040557341, 9661.0, 9664.130228279488, 9722.416655000723, 9508.429494230368, 9910.405375677483, 9963.651272205438, 10162.136218421221, 10277.0, 6895.862082758216, 7112.182099058675, 7138.321859423347, 7232.566046037255, 7355.7057717690695, 9587.904120958701, 10129.290949633454, 10200.897991019994, 10344.689659310232, 10483.52824122901], "unit": "score", "name": "jquery.html", "value": 7124.575984273231}, {"lowerIsBetter": false, "replicates": [1132.3771925441006, 1137.7041969088036, 1164.5865717670222, 1174.049020293562, 1460.5764328344774, 6391.616503009823, 6490.286068532463, 6513.218413790351, 6526.902096468557, 6533.738650453988, 6272.84317892053, 6430.646314452703, 6436.452901503378, 6449.709763060662, 6462.870742585145, 1675.723505621571, 1899.1928430417086, 1923.5864289177823, 1937.8740381875205, 1955.1690531524046, 1926.0369815092454, 1930.3629802165322, 1935.2452543508043, 1935.4870959195825, 1935.709643553471, 1900.3443811884877, 1913.0530387458227, 1984.3848406993807, 1984.5534754680225, 1985.7815640279557, 1916.2430839818333, 1944.0474167657817, 1956.5597740508415, 1959.255482916497, 1959.5297128689083, 1918.539550507882, 1929.2668785861424, 1930.7779605345283, 1930.9710354344695, 1932.5168707823045, 6715.328467153295, 6752.8311792205095, 6766.951122576009, 6769.05233267343, 6780.593164410151, 3642.307961487309, 3731.552213734369, 3753.230587729509, 3759.154190307159, 3762.1347090169415, 2492.538880307131, 2550.1839411388364, 2577.574700174469, 2579.1230981466206, 2590.792736581088, 837.660747397305, 854.175720429782, 859.5444414460346, 864.3733293362325, 899.8245342158282, 9097.226735727405, 9102.453852768855, 9106.499142547158, 9112.726618201465, 9116.635334586608, 3308.9007329780147, 3515.191505953594, 3598.082488965297, 3598.6581274778855, 3601.2977469393218, 7799.649015794303, 7800.687972481037, 7818.14000459949, 7833.882491762628, 7838.451308408471, 3285.5071739239306, 3738.12154143776, 3768.717346199046, 3774.9811250944117, 3779.603141670085, 3291.736661067109, 3333.300006998509, 3335.8999230023137, 3352.4468462703867, 3364.9327013459592, 3058.4341896749174, 3090.799098058619, 3164.177313898403, 3165.635951865519, 3167.0657156138996, 930.6277489004452, 933.6825479337058, 934.5981228071859, 938.2259635800492, 951.6811868024151, 985.963984372269, 1003.6236411345745, 1009.1674368645896, 1013.6502906497246, 1022.8414595737672, 6295.276043254993, 6407.7757278495965, 6410.903836442457, 6423.293437721847, 6444.7744328948265, 377.5714563969859, 379.1696185354121, 382.13827818269624, 384.5212710175849, 386.1466159786846, 4876.609871210295, 4914.213725803854, 4918.8770280743265, 4950.603951683928, 4955.82654607087, 7512.774616761506, 7687.846243075219, 7741.7677469676, 7949.3243074339325, 8284.8343033139, 7596.620168991528, 7618.542887426772, 7638.579878106758, 7651.426143039294, 7652.0, 6281.591696539619, 6302.054691796267, 6462.547621666532, 6468.8059358219325, 6471.417572418411, 5978.133170690138, 6010.909836352371, 6041.305249896142, 6056.606320589148, 6056.848578785565, 7112.253213412724, 7258.963705181441, 7265.019222405119, 7380.151282602569, 7408.222136675571, 7406.925930740624, 7533.434992375484, 7602.657880395506, 7604.733834315773, 7615.961920190363, 4886.096072226649, 5471.261379713687, 5676.489115979582, 5767.884642307215, 5772.884542309046, 6030.517558595389, 6061.121137435135, 6068.726907289094, 6088.330283668704, 6100.8779824404155, 5546.306711661043, 5558.638688485235, 5586.469285417878, 5690.687012214368, 5723.141528770551, 5362.785488580413, 5402.972985135049, 5478.780848766164, 5507.339119305709, 5510.201020852034, 5924.0, 5967.552433567413, 5974.880502390015, 5984.222051133324, 5987.520998320211, 5458.0, 5555.944440555542, 5557.472040156179, 5561.0, 5571.66570005801, 5491.176323551499, 5494.0, 5504.22940788298, 5507.862303442285, 5513.889722205614], "unit": "score", "name": "mootools.html", "value": 3660.758847522966}, {"lowerIsBetter": false, "replicates": [268.95562232231686, 276.095786299868, 282.01717016198546, 283.92392831169866, 284.77929604556476, 5191.818286359978, 5196.974015129919, 5209.166533354664, 5213.218017297408, 5214.713190774506, 5031.52200540948, 5151.047056294588, 5151.562117220032, 5166.354205724285, 5170.0, 4022.195560887827, 4026.879193624196, 4048.7165898387125, 4051.4530538377385, 4056.127932494513, 4038.2125485530332, 4047.7368971016936, 4049.0889549851195, 4049.9190016199805, 4057.2291264659766, 3998.0, 4008.458858054169, 4013.5585085640555, 4016.6585840203616, 4034.394840773878, 4015.859444919443, 4017.919641607181, 4018.276710192179, 4021.2560676274984, 4031.5766844481495, 3543.1319326765106, 3546.8226588670723, 3547.5033495310677, 3547.7161827054033, 3552.0409489437966, 4828.927566086511, 5043.621728370387, 5054.064997975386, 5056.393232812049, 5063.594912406998, 4488.551144885518, 4490.57339552742, 4508.301213311942, 4514.187446259672, 4516.638668906479, 5389.703566303851, 5416.458354164592, 5417.4289456057695, 5427.782888684448, 5429.53848922842, 3650.7627004244905, 3670.376036073874, 3701.759385639925, 3702.9444558331647, 3711.5175027246555, 5432.266644003049, 5524.917126243109, 5573.136163894644, 5624.859378515529, 5693.060644993571, 3683.778973261613, 3685.3366394048794, 3685.6130106338983, 3691.557013158438, 3756.2111956489443, 3802.1825307559006, 3805.5243094613174, 3817.3892177251505, 3826.617338266151, 3828.0238539172333, 4461.263891457938, 4461.486929003141, 4462.553744625511, 4468.609294027679, 4468.798904049326, 5160.767765450564, 5295.0, 5295.285136506599, 5295.391030031518, 5396.83809485716, 1304.9869501304865, 1339.9196048237136, 1346.0308577824146, 1347.6563476313672, 1347.8921686265076, 870.6865528409768, 874.2001069021901, 895.83427065993, 897.7935074932802, 898.577668495819, 4732.361131247238, 4756.143894099096, 4762.0, 4766.428028636586, 4767.189577771787, 5551.2228288039705, 5555.8888822224135, 5556.444355564492, 5557.694326812064, 5558.833235002957, 4749.833755818529, 4752.691075080178, 4753.809847606057, 4761.976190119097, 4763.666543341933, 2954.778391620637, 2998.3253767902047, 2998.550217467354, 2998.8050776699447, 3001.714837090473, 5262.789488420421, 5291.735413229323, 5295.470452954673, 5296.894062118736, 5306.548943339782, 5514.531264842533, 5662.745176467069, 5698.287714035746, 5709.628874123168, 5714.828555143353, 5255.76349064293, 5261.500157485033, 5281.049411106038, 5287.180487024518, 5294.100002999499, 5553.944460555343, 5555.30558680165, 5556.527695145958, 5574.693391863487, 5625.887482250414, 5445.047116754473, 5449.836504904859, 5450.1007333789485, 5455.045367060828, 5461.098918678374, 5252.395974462986, 5255.763490643007, 5287.550558202442, 5292.470752924677, 5295.894082118413, 3575.9284814304087, 3644.1071937375514, 3699.815009249473, 3737.663610275088, 3758.079270578616, 5581.9162712560155, 5597.496225339739, 5604.439556044526, 5607.186957891165, 5613.607047506635, 5378.19327100938, 5396.703181325065, 5397.865053373697, 5399.217113518596, 5402.540784033401, 5382.381026182039, 5387.784488620411, 5392.544013116515, 5401.081816091195, 5402.135658294654, 5239.7118158500125, 5256.842294731164, 5263.9210411844615, 5265.131253343156, 5266.815661451831, 5255.448177941414, 5411.864703382447, 5430.185472179205, 5432.239486471818, 5444.673319600836, 5243.921341179809, 5256.500632439912, 5263.0789611818545, 5268.0, 5276.287701160448], "unit": "score", "name": "prototype.html", "value": 4025.6023656539755}, {"lowerIsBetter": false, "replicates": [609.1532769450465, 622.3247776162863, 628.1138170108351, 629.263761399163, 647.9190101237346, 9442.85835712464, 9500.904990950088, 9509.952450237748, 9767.169790567792, 11845.46695398707, 11204.271722338042, 11254.155938304619, 11259.380734059623, 11293.774124517526, 11356.091512678986, 553.6346011632323, 659.9472042236633, 679.5447050476192, 680.9455243580502, 694.0768777525903, 656.8784774816651, 661.0315887225214, 687.1342108942744, 688.6419062087712, 690.547691262224, 695.8608278344326, 714.6391072508376, 716.8064622551908, 723.9058922340089, 729.4820677319083, 681.7750142452978, 687.7902239816854, 688.2429327739471, 688.3873352716087, 695.8364784275691, 504.9368828896388, 505.0580667055951, 509.36838320482707, 514.4289838279507, 523.5157479331604, 10220.437875916821, 10391.740206494822, 10401.531931063044, 10444.321119127233, 10461.110805581535, 10830.40432776197, 11273.60542381021, 11374.090072794239, 11437.19939604228, 11566.30602163873, 8639.481631102153, 8646.0, 8652.394332396734, 8653.480791152488, 8686.826263474759, 3061.418330517217, 3102.829344386058, 3113.828739419331, 3129.9687003129907, 3171.5876935998403, 38749.41875871864, 38853.22293554142, 39066.80466597677, 40621.39067913983, 40815.7959210202, 7979.401544884041, 8277.172282771795, 8332.250097491255, 8374.120717324593, 8387.832243355098, 14874.628134296729, 14894.180820055, 14954.775678364833, 15075.246237688072, 15085.170315632746, 5257.684538927677, 5539.41836107211, 5643.435656434323, 5655.095184770417, 5842.970785146132, 3329.433996220648, 3355.5134505497053, 3440.174358154075, 3441.0881116504147, 3483.3381657484997, 2483.217786397315, 2483.5902076157595, 2493.5885578879643, 2519.8110141739444, 2527.3428908483925, 402.3060221118547, 428.8434721326693, 429.96345310648945, 430.8944308644402, 472.0723777776685, 375.8891127117452, 446.59359982415845, 495.70010143863163, 506.75422420126944, 514.0567059445958, 6692.899606505906, 6700.128983232149, 6859.588424694534, 7102.112235970504, 7127.681378944912, 428.8884889928641, 477.28883962895037, 499.3558309780415, 499.79508401555915, 512.5003121956138, 3135.6901340118893, 3206.6633003534757, 3208.294175281481, 3263.314703912205, 3338.8981636060043, 44919.55080449219, 47511.287330690066, 48063.75968120207, 48310.758446208245, 48537.514624854004, 41769.58230417718, 42237.78881105575, 42636.57363426326, 42692.57307426948, 42722.78638606787, 38160.809195954396, 38176.236475270896, 38298.80850595729, 38828.0, 38832.41751373732, 6353.96823015882, 6361.427471527585, 6511.837204069747, 6528.314526974599, 6651.401373876374, 26607.600885987114, 29089.563656544746, 29849.850750746107, 29974.100776976724, 30573.54139687862, 32031.35937281288, 36695.0, 37873.0, 38803.61196388, 39020.2195956085, 8733.0, 8863.982178552615, 8869.778255543404, 9236.26109911192, 9269.86095208559, 9572.377795443273, 9731.341200165445, 9905.653302134391, 9933.552990115317, 9982.800343993225, 9000.59497322635, 9013.63945442175, 9337.112974267433, 9369.437833729999, 9564.282678798978, 8525.957370213357, 9452.10205030521, 9668.613255469703, 9927.205823534245, 10000.449975251431, 8208.712695055645, 8621.137886211329, 8829.514376709343, 9265.119813617695, 9480.146786789222, 8411.0, 8554.615042323236, 8592.742217733477, 8720.476771393736, 9026.819463610822, 8278.627461764114, 8305.709300174465, 8352.665893364197, 8375.832483350421, 8664.653413863374], "unit": "score", "name": "yui.html", "value": 5123.779792472804}], "name": "dromaeo_css", "value": 5707.417374665987}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 114.0, 109.0, 113.0, 114.0, 114.0, 103.0, 114.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [155.0, 136.0, 158.0, 178.0, 135.0, 164.0, 163.0, 134.0, 175.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 153.2}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 167.0, 161.0, 161.0, 162.0, 169.0, 162.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 105.0, 97.0, 74.0, 74.0, 74.0, 110.0, 96.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 137.0, 96.0, 95.0, 95.0, 149.0, 96.0, 95.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [76.0, 67.0, 68.0, 68.0, 68.0, 68.0, 70.0, 76.0, 67.0, 67.0], "unit": "score", "name": "json-parse-financial", "value": 69.5}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 72.0, 71.0, 71.0, 71.0, 71.0, 71.0, 72.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.1}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 93.0, 84.0, 85.0, 84.0, 92.0, 84.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [137.0, 127.0, 123.0, 121.0, 126.0, 123.0, 136.0, 120.0, 130.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.3}, {"lowerIsBetter": true, "replicates": [151.0, 148.0, 151.0, 141.0, 148.0, 149.0, 149.0, 148.0, 148.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 74.0, 69.0, 69.0, 70.0, 69.0, 73.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1553.7999999999997}]} 04:51:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1553.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "5707.42"}}} 04:51:03 INFO - Return code: 0 04:51:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:51:03 INFO - # TBPL SUCCESS # 04:51:03 INFO - Running post-action listener: _resource_record_post_action 04:51:03 INFO - Running post-run listener: _resource_record_post_run 04:51:04 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 534695936; Read time: 0; Write time: 643300 04:51:04 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 243245056; Read time: 0; Write time: 352148 04:51:04 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 290545664; Read time: 0; Write time: 291136 04:51:04 INFO - Running post-run listener: _upload_blobber_files 04:51:04 INFO - Blob upload gear active. 04:51:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:04 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 04:51:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:51:05 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:51:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:51:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:05 INFO - (blobuploader) - INFO - Done attempting. 04:51:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:51:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:51:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:06 INFO - (blobuploader) - INFO - Done attempting. 04:51:06 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:06 INFO - Return code: 0 04:51:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c73d1d11fd796b2cea9fe12e5b904dbce5f961688d18065f8ad59770bd8e8b400ef3f724da9d426757422d3e449aae091445d4966e556adb4eb95e9dc6a154ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9abbd0c2799f804790c2bc447fe96c5a0311cefa00b7f8221484def1969463bc2f2e99fb1c1330c98eb56d87f69fd22834b1dac678c650a1dce026a83747662"} 04:51:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:06 INFO - Contents: 04:51:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c73d1d11fd796b2cea9fe12e5b904dbce5f961688d18065f8ad59770bd8e8b400ef3f724da9d426757422d3e449aae091445d4966e556adb4eb95e9dc6a154ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9abbd0c2799f804790c2bc447fe96c5a0311cefa00b7f8221484def1969463bc2f2e99fb1c1330c98eb56d87f69fd22834b1dac678c650a1dce026a83747662"} 04:51:06 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:06 INFO - Copying logs to upload dir... 04:51:06 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.817751 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-01 04:51:05.574129) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:05.577654) ========= 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=33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c73d1d11fd796b2cea9fe12e5b904dbce5f961688d18065f8ad59770bd8e8b400ef3f724da9d426757422d3e449aae091445d4966e556adb4eb95e9dc6a154ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9abbd0c2799f804790c2bc447fe96c5a0311cefa00b7f8221484def1969463bc2f2e99fb1c1330c98eb56d87f69fd22834b1dac678c650a1dce026a83747662"} build_url:https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011175 build_url: 'https://queue.taskcluster.net/v1/task/d26ljM_BS1eH1XQmE46j0g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c73d1d11fd796b2cea9fe12e5b904dbce5f961688d18065f8ad59770bd8e8b400ef3f724da9d426757422d3e449aae091445d4966e556adb4eb95e9dc6a154ec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9abbd0c2799f804790c2bc447fe96c5a0311cefa00b7f8221484def1969463bc2f2e99fb1c1330c98eb56d87f69fd22834b1dac678c650a1dce026a83747662"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:05.602485) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:05.602809) ========= 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=33d5923976266a1c518c4bf7000001ab-1456835314.892234-1764014584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:51:05.685169) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 04:51:05.685492) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 04:51:05.685788) ========= ========= Total master_lag: 0.27 =========