builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1460573291.33 results: success (0) buildid: 20160413110617 builduid: 273290c6cd67453a86fc1284d0811c6e revision: 6f51002d4589638e0120681f8de5512c48bb5155 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:11.334806) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:11.335232) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:11.335554) ========= 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=5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006278 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:11.363834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:11.364146) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:11.385802) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:11.386222) ========= 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=5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004675 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:11.437077) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:11.437380) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:11.437853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:11.438170) ========= 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=5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-13 11:48:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.7M=0s 2016-04-13 11:48:11 (66.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170056 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:11.622201) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:11.622536) ========= 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=5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019628 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:11.675309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:11.675919) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6f51002d4589638e0120681f8de5512c48bb5155 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6f51002d4589638e0120681f8de5512c48bb5155 --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=5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-13 11:48:11,937 truncating revision to first 12 chars 2016-04-13 11:48:11,937 Setting DEBUG logging. 2016-04-13 11:48:11,937 attempt 1/10 2016-04-13 11:48:11,937 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6f51002d4589?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 11:48:12,263 unpacking tar archive at: fx-team-6f51002d4589/testing/mozharness/ program finished with exit code 0 elapsedTime=0.594486 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:12.286740) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:12.287126) ========= echo 6f51002d4589638e0120681f8de5512c48bb5155 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6f51002d4589638e0120681f8de5512c48bb5155'] 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=5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 6f51002d4589638e0120681f8de5512c48bb5155 program finished with exit code 0 elapsedTime=0.004735 script_repo_revision: '6f51002d4589638e0120681f8de5512c48bb5155' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:12.339800) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:12.340326) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 11:48:12.363407) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2016-04-13 11:48:12.363878) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:48:12 INFO - MultiFileLogger online at 20160413 11:48:12 in /builds/slave/test 11:48:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:48:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:48:12 INFO - {'append_to_log': False, 11:48:12 INFO - 'base_work_dir': '/builds/slave/test', 11:48:12 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:48:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:48:12 INFO - 'branch': 'Fx-Team-Non-PGO', 11:48:12 INFO - 'buildbot_json_path': 'buildprops.json', 11:48:12 INFO - 'config_files': ('talos/linux_config.py',), 11:48:12 INFO - 'default_actions': ('clobber', 11:48:12 INFO - 'read-buildbot-config', 11:48:12 INFO - 'download-and-extract', 11:48:12 INFO - 'populate-webroot', 11:48:12 INFO - 'create-virtualenv', 11:48:12 INFO - 'install', 11:48:12 INFO - 'run-tests'), 11:48:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:48:12 INFO - 'download_minidump_stackwalk': True, 11:48:12 INFO - 'download_symbols': 'ondemand', 11:48:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:48:12 INFO - 'tooltool.py': '/tools/tooltool.py', 11:48:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:48:12 INFO - '/tools/misc-python/virtualenv.py')}, 11:48:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:48:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:48:12 INFO - 'installer_path': 'installer.exe', 11:48:12 INFO - 'log_level': 'info', 11:48:12 INFO - 'log_name': 'talos', 11:48:12 INFO - 'log_to_console': True, 11:48:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:48:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:48:12 INFO - 'opt_config_files': (), 11:48:12 INFO - 'pip_index': False, 11:48:12 INFO - 'sps_profile': False, 11:48:12 INFO - 'sps_profile_interval': 0, 11:48:12 INFO - 'suite': 'dromaeojs', 11:48:12 INFO - 'system_bits': '32', 11:48:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:48:12 INFO - 'title': 'talos-linux64-ix-039', 11:48:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:48:12 INFO - 'use_talos_json': True, 11:48:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:48:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:48:12 INFO - 'work_dir': 'build'} 11:48:12 INFO - ##### 11:48:12 INFO - ##### Running clobber step. 11:48:12 INFO - ##### 11:48:12 INFO - Running pre-action listener: _resource_record_pre_action 11:48:12 INFO - Running main action method: clobber 11:48:12 INFO - rmtree: /builds/slave/test/build 11:48:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:48:13 INFO - Running post-action listener: _resource_record_post_action 11:48:13 INFO - ##### 11:48:13 INFO - ##### Running read-buildbot-config step. 11:48:13 INFO - ##### 11:48:13 INFO - Running pre-action listener: _resource_record_pre_action 11:48:13 INFO - Running main action method: read_buildbot_config 11:48:13 INFO - Using buildbot properties: 11:48:13 INFO - { 11:48:13 INFO - "project": "", 11:48:13 INFO - "product": "firefox", 11:48:13 INFO - "script_repo_revision": "production", 11:48:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:48:13 INFO - "repository": "", 11:48:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:48:13 INFO - "buildid": "20160413110617", 11:48:13 INFO - "pgo_build": "False", 11:48:13 INFO - "basedir": "/builds/slave/test", 11:48:13 INFO - "buildnumber": 1557, 11:48:13 INFO - "slavename": "talos-linux64-ix-039", 11:48:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:48:13 INFO - "platform": "ubuntu64_hw", 11:48:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:48:13 INFO - "branch": "fx-team", 11:48:13 INFO - "repo_path": "integration/fx-team", 11:48:13 INFO - "revision": "6f51002d4589638e0120681f8de5512c48bb5155", 11:48:13 INFO - "stage_platform": "linux64", 11:48:13 INFO - "builduid": "273290c6cd67453a86fc1284d0811c6e", 11:48:13 INFO - "slavebuilddir": "test" 11:48:13 INFO - } 11:48:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:48:13 INFO - Running post-action listener: _resource_record_post_action 11:48:13 INFO - ##### 11:48:13 INFO - ##### Running download-and-extract step. 11:48:13 INFO - ##### 11:48:13 INFO - Running pre-action listener: _resource_record_pre_action 11:48:13 INFO - Running main action method: download_and_extract 11:48:13 INFO - mkdir: /builds/slave/test/build/tests 11:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:13 INFO - https://queue.taskcluster.net/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:48:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:48:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:48:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:48:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:48:18 INFO - Downloaded 1361 bytes. 11:48:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:48:18 INFO - Using the following test package requirements: 11:48:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:48:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:48:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:48:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:18 INFO - u'jsshell-linux-x86_64.zip'], 11:48:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:48:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:48:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:48:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:48:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:48:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:48:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:48:18 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')]} 11:48:18 INFO - https://queue.taskcluster.net/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:48:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:48:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:48:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:48:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:48:29 INFO - Downloaded 22199056 bytes. 11:48:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:48:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:48:30 INFO - Return code: 0 11:48:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:48:30 INFO - https://queue.taskcluster.net/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:48:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:48:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:48:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:49:06 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip: The read operation timed out 11:49:06 INFO - retry: attempt #1 caught exception: The read operation timed out 11:49:06 INFO - retry: Failed, sleeping 30 seconds before retrying 11:49:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 11:49:37 INFO - Downloaded 22199056 bytes. 11:49:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:49:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:49:39 INFO - Return code: 0 11:49: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')]} 11:49:39 INFO - https://queue.taskcluster.net/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:49:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:49:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:49:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:49:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:49:40 INFO - Downloaded 10841076 bytes. 11:49:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:49:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:49:40 INFO - Return code: 0 11:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:40 INFO - https://queue.taskcluster.net/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:49:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:49:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:49:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:49:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:49:41 INFO - Downloaded 54157857 bytes. 11:49:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:49:41 INFO - mkdir: /builds/slave/test/properties 11:49:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:49:41 INFO - Writing to file /builds/slave/test/properties/build_url 11:49:41 INFO - Contents: 11:49:41 INFO - build_url:https://queue.taskcluster.net/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:49:42 INFO - Running post-action listener: _resource_record_post_action 11:49:42 INFO - Running post-action listener: set_extra_try_arguments 11:49:42 INFO - ##### 11:49:42 INFO - ##### Running populate-webroot step. 11:49:42 INFO - ##### 11:49:42 INFO - Running pre-action listener: _resource_record_pre_action 11:49:42 INFO - Running main action method: populate_webroot 11:49:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:49:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:49:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:49:42 INFO - '--tppagecycles', 11:49:42 INFO - '7'], 11:49:42 INFO - 'tests': ['tsvgm']}}, 11:49:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:49:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:49:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:49:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:49:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:49:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:49:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'talos_options': ['--disable-e10s'], 11:49:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'talos_options': ['--disable-e10s'], 11:49:42 INFO - 'tests': ['damp', 'tps']}, 11:49:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'tests': ['damp', 'tps']}, 11:49:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:49:42 INFO - 'tests': ['dromaeo_dom']}, 11:49:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:49:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:49:42 INFO - 'tests': ['a11yr', 11:49:42 INFO - 'ts_paint', 11:49:42 INFO - 'tpaint', 11:49:42 INFO - 'sessionrestore', 11:49:42 INFO - 'sessionrestore_no_auto_restore', 11:49:42 INFO - 'tabpaint']}, 11:49:42 INFO - 'other-e10s': {'tests': ['a11yr', 11:49:42 INFO - 'ts_paint', 11:49:42 INFO - 'tpaint', 11:49:42 INFO - 'sessionrestore', 11:49:42 INFO - 'sessionrestore_no_auto_restore', 11:49:42 INFO - 'tabpaint']}, 11:49:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:49:42 INFO - 'ts_paint', 11:49:42 INFO - 'tpaint', 11:49:42 INFO - 'sessionrestore', 11:49:42 INFO - 'sessionrestore_no_auto_restore', 11:49:42 INFO - 'tabpaint']}, 11:49:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:49:42 INFO - 'ts_paint', 11:49:42 INFO - 'tpaint', 11:49:42 INFO - 'sessionrestore', 11:49:42 INFO - 'sessionrestore_no_auto_restore', 11:49:42 INFO - 'tabpaint']}, 11:49:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:49:42 INFO - 'tests': ['a11yr', 11:49:42 INFO - 'ts_paint', 11:49:42 INFO - 'tpaint', 11:49:42 INFO - 'sessionrestore', 11:49:42 INFO - 'sessionrestore_no_auto_restore', 11:49:42 INFO - 'tabpaint']}, 11:49:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:49:42 INFO - 'tests': ['a11yr', 11:49:42 INFO - 'ts_paint', 11:49:42 INFO - 'tpaint', 11:49:42 INFO - 'sessionrestore', 11:49:42 INFO - 'sessionrestore_no_auto_restore', 11:49:42 INFO - 'tabpaint']}, 11:49:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:49:42 INFO - 'tests': ['tsvgx', 11:49:42 INFO - 'tsvgr_opacity', 11:49:42 INFO - 'tart', 11:49:42 INFO - 'tscrollx', 11:49:42 INFO - 'cart']}, 11:49:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:49:42 INFO - 'tsvgr_opacity', 11:49:42 INFO - 'tart', 11:49:42 INFO - 'tscrollx', 11:49:42 INFO - 'cart']}, 11:49:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'talos_options': ['--disable-e10s'], 11:49:42 INFO - 'tests': ['tp5o']}, 11:49:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'tests': ['tp5o']}, 11:49:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'talos_options': ['--disable-e10s', 11:49:42 INFO - '--xperf_path', 11:49:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:42 INFO - 'tests': ['tp5n']}, 11:49:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:42 INFO - 'talos_options': ['--xperf_path', 11:49:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:42 INFO - 'tests': ['tp5n']}}, 11:49:42 INFO - 'talos.zip': {'path': '', 11:49:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:49:42 INFO - Running post-action listener: _resource_record_post_action 11:49:42 INFO - ##### 11:49:42 INFO - ##### Running create-virtualenv step. 11:49:42 INFO - ##### 11:49:42 INFO - Running pre-action listener: _resource_record_pre_action 11:49:42 INFO - Running main action method: create_virtualenv 11:49:42 INFO - Creating virtualenv /builds/slave/test/build/venv 11:49:42 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 11:49:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:49:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:49:42 INFO - Using real prefix '/usr' 11:49:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:49:43 INFO - Installing distribute.............................................................................................................................................................................................done. 11:49:45 INFO - Installing pip.................done. 11:49:45 INFO - Return code: 0 11:49:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:49:45 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')]} 11:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:45 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')]} 11:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:45 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 0x7f32462c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', '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 11:49:45 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 11:49:45 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 11:49:45 INFO - Using env: {'DISPLAY': ':0', 11:49:45 INFO - 'HOME': '/home/cltbld', 11:49:45 INFO - 'LANG': 'en_US.UTF-8', 11:49:45 INFO - 'LANGUAGE': 'en_US:en', 11:49:45 INFO - 'LOGNAME': 'cltbld', 11:49:45 INFO - 'MAIL': '/var/mail/cltbld', 11:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:45 INFO - 'MOZ_NO_REMOTE': '1', 11:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:45 INFO - 'NO_EM_RESTART': '1', 11:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:45 INFO - 'PWD': '/builds/slave/test', 11:49:45 INFO - 'SHELL': '/bin/bash', 11:49:45 INFO - 'SHLVL': '1', 11:49:45 INFO - 'TERM': 'linux', 11:49:45 INFO - 'TMOUT': '86400', 11:49:45 INFO - 'USER': 'cltbld', 11:49:45 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', 11:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:45 INFO - '_': '/tools/buildbot/bin/python'} 11:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:45 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 11:49:45 INFO - Cleaning up... 11:49:45 INFO - Return code: 0 11:49:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:49:45 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')]} 11:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:45 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')]} 11:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:45 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 0x7f32462c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', '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 11:49:45 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 11:49:45 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 11:49:45 INFO - Using env: {'DISPLAY': ':0', 11:49:45 INFO - 'HOME': '/home/cltbld', 11:49:45 INFO - 'LANG': 'en_US.UTF-8', 11:49:45 INFO - 'LANGUAGE': 'en_US:en', 11:49:45 INFO - 'LOGNAME': 'cltbld', 11:49:45 INFO - 'MAIL': '/var/mail/cltbld', 11:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:45 INFO - 'MOZ_NO_REMOTE': '1', 11:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:45 INFO - 'NO_EM_RESTART': '1', 11:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:45 INFO - 'PWD': '/builds/slave/test', 11:49:45 INFO - 'SHELL': '/bin/bash', 11:49:45 INFO - 'SHLVL': '1', 11:49:45 INFO - 'TERM': 'linux', 11:49:45 INFO - 'TMOUT': '86400', 11:49:45 INFO - 'USER': 'cltbld', 11:49:45 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', 11:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:45 INFO - '_': '/tools/buildbot/bin/python'} 11:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:45 INFO - Downloading/unpacking psutil>=0.7.1 11:49:45 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 11:49:45 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 11:49:45 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 11:49:45 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 11:49:45 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 11:49:45 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 11:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:49:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:47 INFO - Installing collected packages: psutil 11:49:47 INFO - Running setup.py install for psutil 11:49:47 INFO - building 'psutil._psutil_linux' extension 11:49:47 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 11:49:47 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 11:49:47 INFO - building 'psutil._psutil_posix' extension 11:49:47 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 11:49:47 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 11:49:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:48 INFO - Successfully installed psutil 11:49:48 INFO - Cleaning up... 11:49:48 INFO - Return code: 0 11:49:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:48 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 0x7f32462c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', '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 11:49:48 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 11:49:48 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 11:49:48 INFO - Using env: {'DISPLAY': ':0', 11:49:48 INFO - 'HOME': '/home/cltbld', 11:49:48 INFO - 'LANG': 'en_US.UTF-8', 11:49:48 INFO - 'LANGUAGE': 'en_US:en', 11:49:48 INFO - 'LOGNAME': 'cltbld', 11:49:48 INFO - 'MAIL': '/var/mail/cltbld', 11:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:48 INFO - 'MOZ_NO_REMOTE': '1', 11:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:48 INFO - 'NO_EM_RESTART': '1', 11:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:48 INFO - 'PWD': '/builds/slave/test', 11:49:48 INFO - 'SHELL': '/bin/bash', 11:49:48 INFO - 'SHLVL': '1', 11:49:48 INFO - 'TERM': 'linux', 11:49:48 INFO - 'TMOUT': '86400', 11:49:48 INFO - 'USER': 'cltbld', 11:49:48 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', 11:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:48 INFO - '_': '/tools/buildbot/bin/python'} 11:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 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 11:49:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:49:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:49:50 INFO - Installing collected packages: mozsystemmonitor 11:49:50 INFO - Running setup.py install for mozsystemmonitor 11:49:50 INFO - Successfully installed mozsystemmonitor 11:49:50 INFO - Cleaning up... 11:49:50 INFO - Return code: 0 11:49:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f32462c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', '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 11:49:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:49:50 INFO - Using env: {'DISPLAY': ':0', 11:49:50 INFO - 'HOME': '/home/cltbld', 11:49:50 INFO - 'LANG': 'en_US.UTF-8', 11:49:50 INFO - 'LANGUAGE': 'en_US:en', 11:49:50 INFO - 'LOGNAME': 'cltbld', 11:49:50 INFO - 'MAIL': '/var/mail/cltbld', 11:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:50 INFO - 'MOZ_NO_REMOTE': '1', 11:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:50 INFO - 'NO_EM_RESTART': '1', 11:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:50 INFO - 'PWD': '/builds/slave/test', 11:49:50 INFO - 'SHELL': '/bin/bash', 11:49:50 INFO - 'SHLVL': '1', 11:49:50 INFO - 'TERM': 'linux', 11:49:50 INFO - 'TMOUT': '86400', 11:49:50 INFO - 'USER': 'cltbld', 11:49:50 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', 11:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:50 INFO - '_': '/tools/buildbot/bin/python'} 11:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:50 INFO - Downloading/unpacking blobuploader==1.2.4 11:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:52 INFO - Downloading blobuploader-1.2.4.tar.gz 11:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:49:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:49:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:53 INFO - Downloading docopt-0.6.1.tar.gz 11:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:49:53 INFO - Installing collected packages: blobuploader, requests, docopt 11:49:53 INFO - Running setup.py install for blobuploader 11:49:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:49:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:49:53 INFO - Running setup.py install for requests 11:49:53 INFO - Running setup.py install for docopt 11:49:53 INFO - Successfully installed blobuploader requests docopt 11:49:53 INFO - Cleaning up... 11:49:53 INFO - Return code: 0 11:49:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:53 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')]} 11:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:53 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')]} 11:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:53 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 0x7f32462c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', '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 11:49:53 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 11:49:53 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 11:49:53 INFO - Using env: {'DISPLAY': ':0', 11:49:53 INFO - 'HOME': '/home/cltbld', 11:49:53 INFO - 'LANG': 'en_US.UTF-8', 11:49:53 INFO - 'LANGUAGE': 'en_US:en', 11:49:53 INFO - 'LOGNAME': 'cltbld', 11:49:53 INFO - 'MAIL': '/var/mail/cltbld', 11:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:53 INFO - 'MOZ_NO_REMOTE': '1', 11:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:53 INFO - 'NO_EM_RESTART': '1', 11:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:53 INFO - 'PWD': '/builds/slave/test', 11:49:53 INFO - 'SHELL': '/bin/bash', 11:49:53 INFO - 'SHLVL': '1', 11:49:53 INFO - 'TERM': 'linux', 11:49:53 INFO - 'TMOUT': '86400', 11:49:53 INFO - 'USER': 'cltbld', 11:49:53 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', 11:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:53 INFO - '_': '/tools/buildbot/bin/python'} 11:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:54 INFO - Running setup.py (path:/tmp/pip-uQOb9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:54 INFO - Running setup.py (path:/tmp/pip-oj5irM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:54 INFO - Running setup.py (path:/tmp/pip-zNw_Ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:54 INFO - Running setup.py (path:/tmp/pip-28ymB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:54 INFO - Running setup.py (path:/tmp/pip-ciqWFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:54 INFO - Running setup.py (path:/tmp/pip-qvjOZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:54 INFO - Running setup.py (path:/tmp/pip-iQzz9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:54 INFO - Running setup.py (path:/tmp/pip-lcEzOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:54 INFO - Running setup.py (path:/tmp/pip-0AR2j5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:54 INFO - Running setup.py (path:/tmp/pip-rysvoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:54 INFO - Running setup.py (path:/tmp/pip-KiD7xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:54 INFO - Running setup.py (path:/tmp/pip-0EKMUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:54 INFO - Running setup.py (path:/tmp/pip-N0zUni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:54 INFO - Running setup.py (path:/tmp/pip-BrJsQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:55 INFO - Running setup.py (path:/tmp/pip-wWNGpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:55 INFO - Running setup.py (path:/tmp/pip-VKtVmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:55 INFO - Running setup.py (path:/tmp/pip-t9AH1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:49:55 INFO - Running setup.py install for manifestparser 11:49:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for mozcrash 11:49:55 INFO - Running setup.py install for mozdebug 11:49:55 INFO - Running setup.py install for mozdevice 11:49:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for mozfile 11:49:55 INFO - Running setup.py install for mozhttpd 11:49:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for mozinfo 11:49:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:49:55 INFO - Running setup.py install for mozInstall 11:49:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Running setup.py install for mozleak 11:49:56 INFO - Running setup.py install for mozlog 11:49:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Running setup.py install for moznetwork 11:49:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Running setup.py install for mozprocess 11:49:56 INFO - Running setup.py install for mozprofile 11:49:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Running setup.py install for mozrunner 11:49:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:49:56 INFO - Running setup.py install for mozscreenshot 11:49:56 INFO - Running setup.py install for moztest 11:49:56 INFO - Running setup.py install for mozversion 11:49:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:49:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:49:57 INFO - Cleaning up... 11:49:57 INFO - Return code: 0 11:49:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:57 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')]} 11:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:57 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')]} 11:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:57 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 0x7f32462c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', '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 11:49:57 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 11:49:57 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 11:49:57 INFO - Using env: {'DISPLAY': ':0', 11:49:57 INFO - 'HOME': '/home/cltbld', 11:49:57 INFO - 'LANG': 'en_US.UTF-8', 11:49:57 INFO - 'LANGUAGE': 'en_US:en', 11:49:57 INFO - 'LOGNAME': 'cltbld', 11:49:57 INFO - 'MAIL': '/var/mail/cltbld', 11:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:57 INFO - 'MOZ_NO_REMOTE': '1', 11:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:57 INFO - 'NO_EM_RESTART': '1', 11:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:57 INFO - 'PWD': '/builds/slave/test', 11:49:57 INFO - 'SHELL': '/bin/bash', 11:49:57 INFO - 'SHLVL': '1', 11:49:57 INFO - 'TERM': 'linux', 11:49:57 INFO - 'TMOUT': '86400', 11:49:57 INFO - 'USER': 'cltbld', 11:49:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', 11:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:57 INFO - '_': '/tools/buildbot/bin/python'} 11:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:57 INFO - Running setup.py (path:/tmp/pip-QOIjF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:57 INFO - Running setup.py (path:/tmp/pip-cNsOMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:57 INFO - Running setup.py (path:/tmp/pip-VieFVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:57 INFO - Running setup.py (path:/tmp/pip-F8EH12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:57 INFO - Running setup.py (path:/tmp/pip-s2tPXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:57 INFO - Running setup.py (path:/tmp/pip-qCTxy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:57 INFO - Running setup.py (path:/tmp/pip-EawYpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:57 INFO - Running setup.py (path:/tmp/pip-XJddfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:57 INFO - Running setup.py (path:/tmp/pip-_SPq_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:57 INFO - Running setup.py (path:/tmp/pip-rhznCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:57 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)) 11:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:57 INFO - Running setup.py (path:/tmp/pip-M9QHU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:58 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)) 11:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:58 INFO - Running setup.py (path:/tmp/pip-o4DHLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:58 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)) 11:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:58 INFO - Running setup.py (path:/tmp/pip-OEZU5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:58 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)) 11:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:58 INFO - Running setup.py (path:/tmp/pip-cMDVa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:58 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)) 11:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:58 INFO - Running setup.py (path:/tmp/pip-csqitN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:58 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)) 11:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:58 INFO - Running setup.py (path:/tmp/pip-GGvxwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:58 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)) 11:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:58 INFO - Running setup.py (path:/tmp/pip-kDKbOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:58 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)) 11:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:49:58 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)) 11:49:58 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)) 11:49:58 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)) 11:49:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:49:58 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 11:49:58 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 11:49:58 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 11:49:58 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 11:49:58 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 11:49:58 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 11:50:00 INFO - Downloading blessings-1.6.tar.gz 11:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:50:00 INFO - Installing collected packages: blessings 11:50:00 INFO - Running setup.py install for blessings 11:50:00 INFO - Successfully installed blessings 11:50:00 INFO - Cleaning up... 11:50:00 INFO - Return code: 0 11:50:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:00 INFO - Reading from file tmpfile_stdout 11:50:00 INFO - Current package versions: 11:50:00 INFO - argparse == 1.2.1 11:50:00 INFO - blessings == 1.6 11:50:00 INFO - blobuploader == 1.2.4 11:50:00 INFO - docopt == 0.6.1 11:50:00 INFO - manifestparser == 1.1 11:50:00 INFO - mozInstall == 1.12 11:50:00 INFO - mozcrash == 0.17 11:50:00 INFO - mozdebug == 0.1 11:50:00 INFO - mozdevice == 0.48 11:50:00 INFO - mozfile == 1.2 11:50:00 INFO - mozhttpd == 0.7 11:50:00 INFO - mozinfo == 0.9 11:50:00 INFO - mozleak == 0.1 11:50:00 INFO - mozlog == 3.1 11:50:00 INFO - moznetwork == 0.27 11:50:00 INFO - mozprocess == 0.22 11:50:00 INFO - mozprofile == 0.28 11:50:00 INFO - mozrunner == 6.11 11:50:00 INFO - mozscreenshot == 0.1 11:50:00 INFO - mozsystemmonitor == 0.0 11:50:00 INFO - moztest == 0.7 11:50:00 INFO - mozversion == 1.4 11:50:00 INFO - psutil == 3.1.1 11:50:00 INFO - requests == 1.2.3 11:50:00 INFO - wsgiref == 0.1.2 11:50:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50:00 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')]} 11:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:00 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')]} 11:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:00 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 0x7f32462c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', '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 11:50:00 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 11:50:00 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 11:50:00 INFO - Using env: {'DISPLAY': ':0', 11:50:00 INFO - 'HOME': '/home/cltbld', 11:50:00 INFO - 'LANG': 'en_US.UTF-8', 11:50:00 INFO - 'LANGUAGE': 'en_US:en', 11:50:00 INFO - 'LOGNAME': 'cltbld', 11:50:00 INFO - 'MAIL': '/var/mail/cltbld', 11:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:00 INFO - 'MOZ_NO_REMOTE': '1', 11:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:00 INFO - 'NO_EM_RESTART': '1', 11:50:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:00 INFO - 'PWD': '/builds/slave/test', 11:50:00 INFO - 'SHELL': '/bin/bash', 11:50:00 INFO - 'SHLVL': '1', 11:50:00 INFO - 'TERM': 'linux', 11:50:00 INFO - 'TMOUT': '86400', 11:50:00 INFO - 'USER': 'cltbld', 11:50:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', 11:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:00 INFO - '_': '/tools/buildbot/bin/python'} 11:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 INFO - Cleaning up... 11:50:01 INFO - Return code: 0 11:50:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:50: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')]} 11:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50: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')]} 11:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f32462c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', '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 11:50:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:50:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:50:01 INFO - Using env: {'DISPLAY': ':0', 11:50:01 INFO - 'HOME': '/home/cltbld', 11:50:01 INFO - 'LANG': 'en_US.UTF-8', 11:50:01 INFO - 'LANGUAGE': 'en_US:en', 11:50:01 INFO - 'LOGNAME': 'cltbld', 11:50:01 INFO - 'MAIL': '/var/mail/cltbld', 11:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:01 INFO - 'MOZ_NO_REMOTE': '1', 11:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:01 INFO - 'NO_EM_RESTART': '1', 11:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:01 INFO - 'PWD': '/builds/slave/test', 11:50:01 INFO - 'SHELL': '/bin/bash', 11:50:01 INFO - 'SHLVL': '1', 11:50:01 INFO - 'TERM': 'linux', 11:50:01 INFO - 'TMOUT': '86400', 11:50:01 INFO - 'USER': 'cltbld', 11:50:01 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', 11:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:01 INFO - '_': '/tools/buildbot/bin/python'} 11:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:01 INFO - Downloading/unpacking jsonschema 11:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:50:03 INFO - Downloading/unpacking functools32 (from jsonschema) 11:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:03 INFO - Downloading functools32-3.2.3-2.tar.gz 11:50:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:50:03 INFO - warning: no files found matching '*.txt' 11:50:03 INFO - no previously-included directories found matching 'build' 11:50:03 INFO - no previously-included directories found matching 'dist' 11:50:03 INFO - no previously-included directories found matching '.git*' 11:50:03 INFO - Installing collected packages: jsonschema, functools32 11:50:03 INFO - Running setup.py install for functools32 11:50:03 INFO - warning: no files found matching '*.txt' 11:50:03 INFO - no previously-included directories found matching 'build' 11:50:03 INFO - no previously-included directories found matching 'dist' 11:50:03 INFO - no previously-included directories found matching '.git*' 11:50:03 INFO - Successfully installed jsonschema functools32 11:50:03 INFO - Cleaning up... 11:50:03 INFO - Return code: 0 11:50:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f32462c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x280d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', '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 11:50:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:50:03 INFO - Using env: {'DISPLAY': ':0', 11:50:03 INFO - 'HOME': '/home/cltbld', 11:50:03 INFO - 'LANG': 'en_US.UTF-8', 11:50:03 INFO - 'LANGUAGE': 'en_US:en', 11:50:03 INFO - 'LOGNAME': 'cltbld', 11:50:03 INFO - 'MAIL': '/var/mail/cltbld', 11:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:03 INFO - 'MOZ_NO_REMOTE': '1', 11:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:03 INFO - 'NO_EM_RESTART': '1', 11:50:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:03 INFO - 'PWD': '/builds/slave/test', 11:50:03 INFO - 'SHELL': '/bin/bash', 11:50:03 INFO - 'SHLVL': '1', 11:50:03 INFO - 'TERM': 'linux', 11:50:03 INFO - 'TMOUT': '86400', 11:50:03 INFO - 'USER': 'cltbld', 11:50:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', 11:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:03 INFO - '_': '/tools/buildbot/bin/python'} 11:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:03 INFO - Downloading/unpacking flake8 11:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:50:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:50:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:50: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 11:50: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 11:50: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 11:50: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 11:50: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 11:50: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 11:50:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:50:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:50:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:50:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:50:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:50:06 INFO - no previously-included directories found matching 'docs/_build' 11:50:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:50:06 INFO - Running setup.py install for pep8 11:50:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:50:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:50:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:50:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:50:06 INFO - no previously-included directories found matching 'docs/_build' 11:50:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:50:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:50:06 INFO - Cleaning up... 11:50:06 INFO - Return code: 0 11:50:06 INFO - Running post-action listener: _resource_record_post_action 11:50:06 INFO - Running post-action listener: _start_resource_monitoring 11:50:06 INFO - Starting resource monitoring. 11:50:06 INFO - ##### 11:50:06 INFO - ##### Running install step. 11:50:06 INFO - ##### 11:50:06 INFO - Running pre-action listener: _resource_record_pre_action 11:50:06 INFO - Running main action method: install 11:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:06 INFO - Reading from file tmpfile_stdout 11:50:06 INFO - Detecting whether we're running mozinstall >=1.0... 11:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:50:06 INFO - Reading from file tmpfile_stdout 11:50:06 INFO - Output received: 11:50:06 INFO - Usage: mozinstall [options] installer 11:50:06 INFO - Options: 11:50:06 INFO - -h, --help show this help message and exit 11:50:06 INFO - -d DEST, --destination=DEST 11:50:06 INFO - Directory to install application into. [default: 11:50:06 INFO - "/builds/slave/test"] 11:50:06 INFO - --app=APP Application being installed. [default: firefox] 11:50:06 INFO - mkdir: /builds/slave/test/build/application 11:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:50:22 INFO - Reading from file tmpfile_stdout 11:50:22 INFO - Output received: 11:50:22 INFO - /builds/slave/test/build/application/firefox/firefox 11:50:22 INFO - Running post-action listener: _resource_record_post_action 11:50:22 INFO - ##### 11:50:22 INFO - ##### Running run-tests step. 11:50:22 INFO - ##### 11:50:22 INFO - Running pre-action listener: _resource_record_pre_action 11:50:22 INFO - Running main action method: run_tests 11:50:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:50:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:50:22 INFO - Python 2.7.3 11:50:22 INFO - Return code: 0 11:50:22 INFO - grabbing minidump binary from tooltool 11:50:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:50:22 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 0x2967410>, '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 0x2968310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29687a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:50:22 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 11:50:22 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 11:50:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:50:22 INFO - Return code: 0 11:50:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:50:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:50:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:50:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:50:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:50:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:50:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:50:23 INFO - Return code: 0 11:50:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 11:50:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 11:50:23 INFO - Using env: {'DISPLAY': ':0', 11:50:23 INFO - 'HOME': '/home/cltbld', 11:50:23 INFO - 'LANG': 'en_US.UTF-8', 11:50:23 INFO - 'LANGUAGE': 'en_US:en', 11:50:23 INFO - 'LOGNAME': 'cltbld', 11:50:23 INFO - 'MAIL': '/var/mail/cltbld', 11:50:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:23 INFO - 'MOZ_NO_REMOTE': '1', 11:50:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:23 INFO - 'NO_EM_RESTART': '1', 11:50:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:23 INFO - 'PWD': '/builds/slave/test', 11:50:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:23 INFO - 'SHELL': '/bin/bash', 11:50:23 INFO - 'SHLVL': '1', 11:50:23 INFO - 'TERM': 'linux', 11:50:23 INFO - 'TMOUT': '86400', 11:50:23 INFO - 'USER': 'cltbld', 11:50:23 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989', 11:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:23 INFO - '_': '/tools/buildbot/bin/python'} 11:50:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 11:50:23 INFO - mozversion application_buildid: 20160413110617 11:50:23 INFO - mozversion application_changeset: 6f51002d4589638e0120681f8de5512c48bb5155 11:50:23 INFO - mozversion application_display_name: Nightly 11:50:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:50:23 INFO - mozversion application_name: Firefox 11:50:23 INFO - mozversion application_remotingname: firefox 11:50:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:50:23 INFO - mozversion application_vendor: Mozilla 11:50:23 INFO - mozversion application_version: 48.0a1 11:50:23 INFO - mozversion platform_buildid: 20160413110617 11:50:23 INFO - mozversion platform_changeset: 6f51002d4589638e0120681f8de5512c48bb5155 11:50:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:50:23 INFO - mozversion platform_version: 48.0a1 11:50:23 INFO - using testdate: 1460573423 11:50:23 INFO - actual date: 1460573423 11:50:23 INFO - starting webserver on 'localhost:48219' 11:50:23 INFO - SUITE-START | Running 2 tests 11:50:23 INFO - TEST-START | dromaeo_css 11:50:23 INFO - operating with platform_type : linux_ 11:50:23 INFO - Initialising browser for dromaeo_css test... 11:50:23 INFO - TEST-INFO | started process 18022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYRdayd/profile http://localhost:48219/getInfo.html) 11:50:28 INFO - PROCESS | 18022 | __metrics Screen width/height:1600/1200 11:50:28 INFO - PROCESS | 18022 | colorDepth:24 11:50:28 INFO - PROCESS | 18022 | Browser inner width/height: 1024/697 11:50:28 INFO - PROCESS | 18022 | __metrics 11:50:29 ERROR - PROCESS | 18022 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:50:30 INFO - TEST-INFO | 18022: exit 0 11:50:30 INFO - Browser initialized. 11:50:30 INFO - Running cycle 1/1 for dromaeo_css test... 11:50:30 INFO - TEST-INFO | started process 18103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYRdayd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:42 INFO - PROCESS | 18103 | RSS: Main: 154804224 11:50:42 INFO - PROCESS | 18103 | 11:51:33 INFO - PROCESS | 18103 | 1460573493820 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] 11:53:45 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:48219/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48219/tests/dromaeo/cssquery-ext.html) 11:53:46 INFO - PROCESS | 18103 | RSS: Main: 240033792 11:53:46 INFO - PROCESS | 18103 | 11:56:48 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:48219/tests/dromaeo/cssquery-ext.html (next: http://localhost:48219/tests/dromaeo/cssquery-jquery.html) 11:56:48 INFO - PROCESS | 18103 | RSS: Main: 234725376 11:56:48 INFO - PROCESS | 18103 | 11:59:50 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:48219/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48219/tests/dromaeo/cssquery-mootools.html) 11:59:51 INFO - PROCESS | 18103 | RSS: Main: 231944192 11:59:51 INFO - PROCESS | 18103 | 12:02:53 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:48219/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48219/tests/dromaeo/cssquery-prototype.html) 12:02:54 INFO - PROCESS | 18103 | RSS: Main: 228691968 12:02:54 INFO - PROCESS | 18103 | 12:05:57 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:48219/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48219/tests/dromaeo/cssquery-yui.html) 12:05:57 INFO - PROCESS | 18103 | RSS: Main: 207499264 12:05:57 INFO - PROCESS | 18103 | 12:09:00 INFO - PROCESS | 18103 | Cycle 1(1): loaded http://localhost:48219/tests/dromaeo/cssquery-yui.html (next: http://localhost:48219/tests/dromaeo/cssquery-dojo.html) 12:09:00 INFO - PROCESS | 18103 | RSS: Main: 299343872 12:09:00 INFO - PROCESS | 18103 | 12:09:00 INFO - PROCESS | 18103 | __start_tp_report 12:09:00 INFO - PROCESS | 18103 | _x_x_mozilla_page_load 12:09:00 INFO - PROCESS | 18103 | _x_x_mozilla_page_load_details 12:09:00 INFO - PROCESS | 18103 | |i|pagename|runs| 12:09:00 INFO - PROCESS | 18103 | |0;dojo.html;2594.7275536068714;2677.370817857803;2683.2889284339667;2699.3926366567525;2719.7552220300167;4499.842505512308;4593.448786145659;4641.791119399627;4650.8837279068;4660.370849935262;4598.057398233363;4613.215753321935;4625.999999999992;4680.625549956004;4697.013627138305;4218.91562168758;4242.087951090522;4271.551487093857;4302.204092242945;4413.051193993291;4336.84821031264;4362.5637436256275;4378.365137055125;4384.276594361926;4404.537523560028;4140.3375459926565;4230.661547076226;4245.299525578307;4248.660107191417;4316.805743741539;4246.278132717445;4262.509811371701;4263.040815816447;4265.957340426618;4301.956980430187;4242.660587153051;4245.15096980602;4249.150169966019;4276.31578947367;4280.101178752466;4424.579664931826;4492.483364413069;4523.7285762854335;4574.451065872084;4585.862424127282;4959.404871415417;4975.378077740283;4988.176950803113;4993.0263598598285;5014.674046187022;4871.196252618313;4994.950050499521;4996.775145118479;5002;5003.874903127451;4643;4685;4686.929696054562;4731.550502702238;4734.289856521515;5084.084864724311;5144.125498665236;5144.125498665236;5147.3051138096625;5198.376194856642;4737.194676904865;4841.661083724105;4920.286558449005;4926;4937.679050861682;4958.727270000185;4980.5019498049905;4981.4769449207315;4993.800247990112;5031.371078615173;4912.214045752662;4926.088673595396;4935.481774413634;4937.506249375106;4979.90040199194;4770.522947705202;4909.803607855646;4911.189653707098;4968.9316796888115;4968.975155124202;4193.685473589432;4196.28663127263;4196.328587425997;4225.408442818008;4225.978870105691;3662.487251784752;3688.944665830015;3691.0218792020137;3723.590405055442;3729.701623870084;4153.958460415357;4193.622573968358;4227.492700875853;4255.893602659897;4260.552641972548;5009.348784657971;5016.949830501649;5017.122003649347;5025.045241404122;5025.346704928336;4295.22685916538;4295.591918767712;4298.570142985676;4321.891952701145;4341.0232697643405;4340.565943405634;4426.84506042287;4480.529544397857;4482.125985432875;4515.0518391137575;4690.179218636725;4694.084653492673;4712.340272361941;4712.85861424151;4759.2147295697205;4971.105201063843;4983.700977941335;4984.376952880745;4984.426790918946;5034.924476132787;4604.907901841877;4715.717056976455;4756.025014871874;4757;4801.639877009168;4876.390451193601;4877.268409738567;4896.779644916059;4897.926531101965;4949.356583644103;4783.689060211075;4954.355933728736;4969.0807200668;4969.503049695146;5019.723915184554;4852.417709874838;4896.2655601660035;4896.485868983706;4898.044881248123;4939.75301234944;4822.734749588806;4867.780949857194;4867.95132048675;4870.928395752929;4918.385201849769;4629.907401852011;4697.882552936204;4765.809367625395;4776.9761151194025;4825.9034819304115;4855.150348689036;4876;4884.12085824555;4899.975500122477;4927.433345165352;4773.188557945088;4777.8327758528285;4780.832670856643;4785.760711964457;4833.081714474239 12:09:00 INFO - PROCESS | 18103 | |1;ext.html;586.0769288370815;593.1695626123428;617.2253821454076;620.6648409858676;646.237439821011;26884.19347419578;27576.44847103059;34155.82922085389;35220.647793522054;35249.823750881274;37418.4387234191;38257.23485530288;38279.23441531168;38383.42424863629;38418;7540.8114797129965;7747.845043099134;7751.573663448508;7754.883676744853;7755.612219389036;7610.1628820829665;7645.120811106738;7707.267809558083;7731.342835858959;7732.884006739903;7603.391728661693;7694.230576942317;7799.844003119934;7840.921590784104;7850.371970242395;7814.374850012014;7877.369810415153;7882.290593846553;7885.487443316195;7886.881696774553;7761.534307941542;7847.6860925562905;7871;7873.763787086396;7876.80307992299;37697;38033.23933521314;38259;38290.42564361537;38298;3162.58886344776;3178.4596618574897;3198.9680103198903;3281.064896504509;3293.5883014623173;28795.28011799701;28867.711322886713;28876.855615721997;28935.56596651052;29741.553876691865;3044.680308567613;3064.0960916529675;3079.907602771898;3101.379724055198;3165.0346644273486;240010;240745;240861;240939;241305;48822;50665;50829.49170508247;50857.74571127121;50866;57896.42103578994;59537.40462595318;60147.69926150341;60244;60315;12786.168899021533;13025.088243822842;13033.348332583522;13042.087053906136;13042.739145217232;9631.277654175965;9674.516274186262;9722.125008749246;9726.902730972599;9731.708048758548;17624;17636.647267054843;17752.733708994376;18348.08259587042;18425.07874606264;6762.7394741312655;6949.82625434358;7022.1924478685605;7154.427645788324;7270.8182295441975;821.9630116644765;833.4249367936104;892.3887137310962;940.2732076976822;985.4186030242191;26583.468330633666;26616.334591635365;26799.86600066987;27243.318917027234;27422.862885685445;927.4342650982895;945.6170251048336;971.2424309038961;1022.6983040003217;1022.8056669232822;13884;14251.714965700628;14508.347124379428;14512.85487145115;14522.273886305642;355054;361200;363939;364072;364347;49236.50763492319;50639.7468012665;50703.49296507062;50704.49295507072;50724.23913641298;995.875515560555;1161.7792619402287;1203.4043148641479;1240.094730846469;1249.0632025980333;24521;26767;27135.321616959733;27188;27350.863245683646;39367;39628.60371396249;39848.40227396534;40043;40209.597904020586;225549;228528;228974;229557;229653;22690.546189076456;24944.875275623504;25457;25476.363090922874;25567.105151319614;39302.41046384249;39942.20115597614;40272.1945561093;40571;40573.59426405816;34292.65707342895;35078.29843403168;35154.296914061066;35694.64305356913;35830.82084589665;34742.30515389729;34942;35104.82447587746;35433.46849797203;35515.46726799048;32234.516482252315;32290;32531.674683252866;32942.67057329396;32988.835055824566;30828;32144.517832233003;32161.839190803898;32232.83883580567;32318.676813231566;22672.206472774033;23091.88454057719;23306.766932330458;23371.88314058419;23420.88289558541 12:09:00 INFO - PROCESS | 18103 | |2;jquery.html;370.79791513625054;380.95618006661755;383.64512825636314;386.2526012166458;386.2622391232746;16202.351905923764;16271.83728162718;17192;17240.396586119456;17241.913790431045;15218.619534511643;15226.771598426005;15903.363865445397;15929.681406371865;15955.282012309444;4444.622207112399;4595.793189306489;4627.699199552035;4629.444466663988;4631.328457373679;3417.7607567470286;5055.46917573655;5373.623846330758;5383;5386.622936394454;5349.679019258838;5356.250124982505;5358.490943360374;5370.516653501184;5375.247465354853;5047.949520504784;5370.113931201347;5374.91937620936;5375.354957405098;5381.596380271495;3367.2255381262203;3572.464130380438;3577.606463289036;3577.695895848856;4938.555530002282;11945.761084778344;12109.636710898687;12158.817617735742;12936.547220847318;18934.24263029477;1895.5261184703825;1977.8615496915222;1991.9203231870708;2032.9530291899684;2471.0486462711983;8624.353173512012;8675.95662021692;9149.176574108296;11067.335959842436;13481.59555213345;1697.3719723702309;1726.9827301727073;1732.2205007746566;1752.4830175098377;1826.8538516918748;67522.66238668824;71661;71698.64150679266;71861;73173;9724.222062235005;9887.80224395508;9954.701358959099;10096.798064038678;10137.949310253549;13904.165750055028;14018.719625607635;14042.438302467786;14055.859441405659;14086.929565352108;6870.828229294308;6993.440524758007;7154.749583764543;7230.385417239593;7244.49288549807;6536.7712130075215;6538.901916471256;6552.6068435894;6697.330266973264;6704.463642908653;4074.5517993020744;4080.8571699990357;4311.374850646639;4339.284018136972;4396.098799746108;1652.983470165307;1735.488031030849;1746.3974928649595;1758.903260320669;1782.6969415199446;788.7278888783361;806.7741032510907;859.7291853066264;865.7575878753959;898.7528429681889;14894.851051489562;15652.37390504367;15825.446109386115;16187.10970896612;16259.674806503805;811.7564730580921;818.2594751749676;824.4599787139433;830.3689196210923;856.8157846063126;8661.913380866237;8674.86987695185;8947.821043579092;9017.188453039258;9190.632374704937;253899;402653;405782;408712;409980;50734;51553.742231288605;79860.20139798528;88141.55929220314;88234.55882720546;993.562832353762;1004.4877112672443;1010.0909181736349;1043.984340234897;1056.75166335911;14875.925620371829;14876.479323223635;15246.466373676869;15253;15334.156621385484;34396.31207375888;34398.65601343955;34627;34722.305553888276;35115.82442087773;44390;46181.30728039149;47656.52343476521;49001.754991224814;49031.26453103135;6933.445324374139;7623.542587444771;7835.177306382976;7840.686372545262;8057.476264042818;10015.899841001497;11560.6531804046;11568.190226684052;11673.357965311989;11684.88315116838;9366.859497107413;9418.152366286793;9678.419294842332;9878.75303117399;10059.245556583139;9641.903580964381;9932.751681208028;10114.949425252827;10358.171346292127;10512.264141510326;5017.899642007213;6692.799216023527;9006.819863602823;9528.333016688764;10334.224933129895;7666.19504951972;7716.5370077795515;7830.295273425191;7842.980412546332;7922.247386498273;9657.130858222794;10059.346142500714;10098.798024039625;10127.949360253151;10389.116925061153 12:09:00 INFO - PROCESS | 18103 | |3;mootools.html;1323.6889331007217;1491.2635314198449;1499.8050253467047;1665.4110392105017;1818.045526098798;7607.1632120466775;7962.840743185133;7963.2036796320335;7971.322437592811;7980.561069141202;7712;7860.135385107634;7876.960615196916;7879.842403151948;7884.369250459964;1928.633559623674;2186.1036974840317;2206.09550084465;2233.2630232023475;2259.378670865509;2252.042881775247;2273.7044184256024;2278.236790675126;2278.236790675126;2278.760730123338;2241.4060274027397;2278.874661893595;2281.7946384825364;2282.1327895399727;2285.8399912006166;1945.4552725236886;2178.4989452425953;2253.2451628704403;2254.447660323215;2254.6505291679814;2178.0198910490344;2190.233418303597;2195.6157672407426;2197.1540956731615;2234.441389652587;7825.178356272566;7870.212978702084;7875.291223789829;7875.4487185897015;7876.5667888266125;4403.471583409979;4585.266357382836;4604.263317869125;4613.100445413146;4700.059988002413;3046.817190968549;3061.6172978377704;3123.875044998197;3140.78574604903;3163.43058249515;943.7310366545502;946.6118891254622;952.0669743651191;957.3059531839431;963.2919803944095;10710.250282480307;10720.78558428835;10731.624393146203;10747.140228781678;10751.83872241917;4215.3044747616295;4295.205387003414;4330.999999999937;4362.258416069276;4379.49635791888;9142.131497507726;9167.633294668138;9185.540722963826;9186.219171370374;9192.770180745534;4013.2776100301644;4687.554682305175;4688.390509233778;4689.3903792507435;4721.3390125382475;4182.790860456965;4255.893602659959;4276.615104640598;4278.165757677285;4302.182585308781;3629.292288003867;3679.300932822755;3732.1975775207916;3767.453719210699;3821.4267859820693;1174.5536696055615;1219.725561748617;1239.1449899569268;1254.2913254011455;1259.2696236182992;819.8852160697508;826.6321486938255;840.2983508770124;852.1648784191527;859.0679113162164;5058.317127187856;5205.6356055075785;5209.984053109683;5359.383670877821;5369.463053694677;433.36944745396005;433.427875204733;436.151684972725;439.94720633524184;442.38066706610357;3519.824008799601;3579.069441945113;3602.963970360315;3630.7821530708243;3637.0907273181706;9626.807463850684;9900.306978511435;10105.090541851268;10140.29017968735;10145.28982971185;9929.851052234222;9950.10449059588;10030.29787914839;10044.246681498917;10047.145992590566;7392.778216653509;7406.185319614838;7503.549787012906;7565.6973721051645;7621.352185064332;5249.842504724865;5474.835754927359;5482.342118945752;5493.780248790164;5739.110437882135;8960.865587016331;8976.102389760972;9037.864432033657;9113.134252246025;9241.907580924104;8451.873221901553;9226.40028398152;9238.445693258425;9249.352545321763;9255.213306868991;6182;6735.730570777114;6793.116894803644;6949.270326615632;7006.369426751617;7560.092788865151;7574.697012119454;7640.961795190989;7642.388608911163;7674.040744906887;6429.51778616615;6657.73369065232;6711.060451536691;6788.7284508619105;6897.655117244218;6625.236044641193;6650.866982660416;6702.36327548882;6718.664066796543;6731.79804605843;6403.423691867754;6406.231252249573;6474.741010359533;6475.1582294303325;6486.643234622141;4729.101470720552;4799.520047995173;4833.419989601271;4869.659123861437;4881.121398148367;4618.884527886829;4734.431868175841;4743.66794324394;4805.303231031551;4818.012307476889 12:09:00 INFO - PROCESS | 18103 | |4;prototype.html;315.8720718109165;321.1793866670656;324.4532961959099;327.80004197439575;327.89507357645533;4669.9066018679605;4780.8565743027675;5012.674176178551;5050.46970068143;5050.84847454576;4960.206366981275;4966.354373931384;4985.551300382965;5003.899922001567;5007.148784706599;3974.4833171687715;3992.2414741199223;3997.6601988830985;3999.4200840878057;4003.939940900889;3762.341590221714;3819.178876541543;3967.662748666367;3987.5414327352437;3989.740666856645;3931.7444366116256;3943.3296339622334;3944.881653550398;3953.0907891185043;3967.0875698589343;3913.5499417566916;3930.6658933990643;3935.626115519021;3952.426898099788;3958.4853968984135;3516.3318969395987;3526.6297038811067;3529.3823580873245;3529.9647003529894;3539.50446937429;4588.678792484528;4816.927746083811;4822.397200349957;4836.226203807374;4842;4439.955600443986;4441.711288766252;4454.710443821141;4455.242608756519;4459.420275364214;5018.422881368653;5234.790608375661;5285.995660824431;5292.57659387252;5296.814611488579;3728.6271372862766;3748.137928276484;3750.4186851038135;3750.474933509311;3756.868509602178;5174.97412512935;5311.7344132793205;5456.345238571397;5503;5528.861778455531;3813.199228162117;3813.485179500732;3825.101101241206;3825.1775868187915;3826.253880493333;3858.479105320802;3867.149227170018;3878.84484620612;3883.0874744435037;3885.96114038856;4406.801693923781;4417.1668757465295;4431.357453169272;4438.379991303151;4442.511758560854;5159.813242954142;5241.816536421207;5260.842614624777;5260.973695131576;5278.313819203479;1308.3327502973552;1315.7302752935625;1317.9604611861469;1322.213283096556;1326.270551196838;887.8801361816202;906.3655441191192;921.2906062331967;922.5617831530104;928.1739252065667;4587.266037433995;4620.561046700558;4642.141203877293;4645.883852903637;4657.953420465819;5417.972910135424;5426.213199086111;5436.673799572039;5447.1829225616475;5492.588055895823;4506.594406503365;4608.193566125915;4608.585227329557;4615.538446155425;4618.976905115453;2891.465078960357;2895.3340731631843;2915.3877685686243;2917.0519581136214;2926.0929111975356;5113.571053749513;5123.487651234846;5146.536811686966;5157.329547158845;5160.561352285023;5340.866478338073;5538.47384498472;5553.694546799884;5585.609007369527;5603.691796951125;5093.414257360377;5107.336046313955;5142.534377702337;5143.588512918957;5154.484551544891;5416.647917885325;5450.874159077884;5454.372747134131;5462.126059830408;5464;5182.714950677749;5258.921116183337;5303.549198318186;5330.387005494418;5339.917432201367;4905.1416002200185;4966.404031516241;5121.9743901281745;5159.355080614923;5193.182386164963;3869.438931354994;3877.9418308724826;3886.3587508060855;3886.84452621892;3890.669293110004;5452.781888724407;5456.590755693418;5499.312585926759;5503;5509.393966663583;5015.749212539431;5315.495027972336;5318.308619879391;5322.760475778522;5331.866703332447;5300.31095957523;5301.416844147064;5307.203919412119;5317.361916570037;5319.335083114611;5191.610629202901;5198.402183748917;5208.114620514598;5210.8957820844125;5222.138347172674;5051.823186188466;5331.88030513581;5369.409364969928;5371.355437347544;5375.865603359947;5213.322268105122;5232.869178270574;5244.7639856207325;5245.160774276097;5260.921086183634 12:09:00 INFO - PROCESS | 18103 | |5;yui.html;634.1629049654458;687.3744892148145;778.4511919097035;794.51534563916;811.7037281392294;12212.145149839504;12343.13598048137;12378.319192444413;12380.071494637894;12393.38033098345;12776.616701498946;12841.229526228433;12849.614511564645;12859.485620575166;12905.1611645243;647.2621211818507;805.9032916050082;836.7322456813807;843.0305149078578;843.0852525010371;825.694493037577;830.1490971753971;833.212614079695;834.6744769539885;834.7746108550688;882.1487264789477;884.725735022142;885.3536918049828;885.6944354197824;885.7829831691245;686.5194363945259;854.218390172991;880.3969281042506;881.7971866470748;882.1707594860875;646.7703965092419;647.3914520350855;648.5719425179359;648.8313038609948;648.8572514046903;12786.61640150797;12839.871601284054;12846.100772945898;12846.935765321114;12849.35753212345;12307.26156430617;12693.873061269362;12720.23678579279;12790.552330668475;12916.418761155677;9748.610055597768;9783.168430683401;9961.90038099617;10076;10340.327878687936;4200.558941311179;4221.366794980747;4242.66058715302;4267.231898258312;4410.184115938561;45488.77255613734;45785.542144578794;46055.76972115151;46148.538514615095;46152.07695846098;9342.392744471723;9437.386569872937;9447.716568502818;9463.90536094644;9718.70843874685;16835.49493515172;17456.738148927776;17477.91261043712;17503.299868005393;17504.737428938577;6557.573757705733;6867.141607299088;6916.100906882073;6927.203371612329;7003.5797852129035;3746.3069332173636;3777.20678657485;3805.771653700787;3837.654611085016;3969.325214713506;2904.3465220325256;3015.969840301569;3026.7124623160767;3059.265776213693;3059.7705172111737;469.61960811742597;565.9830205093854;584.2842517915519;585.748128304833;610.2189197826789;570.1675553691574;598.3119412675371;615.4184295840478;617.7004152985799;645.3868824616633;7969.965352317926;8205.138460461685;8269.255766980881;8281.29608983231;8574.442661227;458.60379517023284;542.0216509200931;614.7950017964839;615.5691016288616;624.6782906803;3668.413053911415;3813.3898576228225;3844.0774214188395;3861.787601681878;3933.842646294116;48729.269060964114;50590.24114638283;50694.74652626713;50725.492745072814;56607.43392566022;43578.564214358084;43982.56017439849;43994.34008489875;44169;45049.549504505194;35354.116147096014;37523.62476375256;39219.41170882439;41170.05959284905;42670.78664606657;8232;8297.294729948022;8679.566021699016;8697.826043478968;8888.333374996771;25517.23448296554;26200.213993580222;26543.867280664246;27547.44905101927;27809.58285625677;35225.64774352223;36531.81734091313;36596.268074637825;37164.44253336148;37436;10817.729556760829;10841.241113122005;10871.51078201467;10992.120630349713;11055.83416248773;11824.704382390164;12084.75830483403;12089.879101208875;12115;12270;11381.658550243506;11518.884811151782;11568.132390070947;11618.88381116178;12124.636260911833;10584.576616935545;10832.350058996486;11180.776384472427;11436.94281528587;11465.254758440675;11711.648650540497;11719.06247500215;11784.70538236551;12111.283212200602;12128.575499857816;8786.077461866413;8881.245094167069;9460.95269523648;9477;9485.098915603006;9305.582455565302;9377;9483.28875334339;9520.47637379923;9703.417794932328 12:09:00 INFO - PROCESS | 18103 | __end_tp_report 12:09:00 INFO - PROCESS | 18103 | __start_cc_report 12:09:00 INFO - PROCESS | 18103 | _x_x_mozilla_cycle_collect,860 12:09:00 INFO - PROCESS | 18103 | __end_cc_report 12:09:00 INFO - PROCESS | 18103 | __startTimestamp1460574540751__endTimestamp 12:09:00 INFO - PROCESS | 18103 | 12:09:00 INFO - PROCESS | 18103 | ------- Summary: start ------- 12:09:00 INFO - PROCESS | 18103 | Number of tests: 6 12:09:00 INFO - PROCESS | 18103 | 12:09:00 INFO - PROCESS | 18103 | [#0] dojo.html Cycles:165 Average:4598.10 Median:4734.29 stddev:474.72 (10.0%) stddev-sans-first:449.41 12:09:00 INFO - PROCESS | 18103 | Values: 2594.7 2677.4 2683.3 2699.4 2719.8 4499.8 4593.4 4641.8 4650.9 4660.4 4598.1 4613.2 4626.0 4680.6 4697.0 4218.9 4242.1 4271.6 4302.2 4413.1 4336.8 4362.6 4378.4 4384.3 4404.5 4140.3 4230.7 4245.3 4248.7 4316.8 4246.3 4262.5 4263.0 4266.0 4302.0 4242.7 4245.2 4249.2 4276.3 4280.1 4424.6 4492.5 4523.7 4574.5 4585.9 4959.4 4975.4 4988.2 4993.0 5014.7 4871.2 4995.0 4996.8 5002.0 5003.9 4643.0 4685.0 4686.9 4731.6 4734.3 5084.1 5144.1 5144.1 5147.3 5198.4 4737.2 4841.7 4920.3 4926.0 4937.7 4958.7 4980.5 4981.5 4993.8 5031.4 4912.2 4926.1 4935.5 4937.5 4979.9 4770.5 4909.8 4911.2 4968.9 4969.0 4193.7 4196.3 4196.3 4225.4 4226.0 3662.5 3688.9 3691.0 3723.6 3729.7 4154.0 4193.6 4227.5 4255.9 4260.6 5009.3 5016.9 5017.1 5025.0 5025.3 4295.2 4295.6 4298.6 4321.9 4341.0 4340.6 4426.8 4480.5 4482.1 4515.1 4690.2 4694.1 4712.3 4712.9 4759.2 4971.1 4983.7 4984.4 4984.4 5034.9 4604.9 4715.7 4756.0 4757.0 4801.6 4876.4 4877.3 4896.8 4897.9 4949.4 4783.7 4954.4 4969.1 4969.5 5019.7 4852.4 4896.3 4896.5 4898.0 4939.8 4822.7 4867.8 4868.0 4870.9 4918.4 4629.9 4697.9 4765.8 4777.0 4825.9 4855.2 4876.0 4884.1 4900.0 4927.4 4773.2 4777.8 4780.8 4785.8 4833.1 12:09:00 INFO - PROCESS | 18103 | 12:09:00 INFO - PROCESS | 18103 | [#1] ext.html Cycles:180 Average:43214.67 Median:35762.73 stddev:74503.19 (208.3%) stddev-sans-first:74643.44 12:09:00 INFO - PROCESS | 18103 | Values: 586.1 593.2 617.2 620.7 646.2 26884.2 27576.4 34155.8 35220.6 35249.8 37418.4 38257.2 38279.2 38383.4 38418.0 7540.8 7747.8 7751.6 7754.9 7755.6 7610.2 7645.1 7707.3 7731.3 7732.9 7603.4 7694.2 7799.8 7840.9 7850.4 7814.4 7877.4 7882.3 7885.5 7886.9 7761.5 7847.7 7871.0 7873.8 7876.8 37697.0 38033.2 38259.0 38290.4 38298.0 3162.6 3178.5 3199.0 3281.1 3293.6 28795.3 28867.7 28876.9 28935.6 29741.6 3044.7 3064.1 3079.9 3101.4 3165.0 240010.0 240745.0 240861.0 240939.0 241305.0 48822.0 50665.0 50829.5 50857.7 50866.0 57896.4 59537.4 60147.7 60244.0 60315.0 12786.2 13025.1 13033.3 13042.1 13042.7 9631.3 9674.5 9722.1 9726.9 9731.7 17624.0 17636.6 17752.7 18348.1 18425.1 6762.7 6949.8 7022.2 7154.4 7270.8 822.0 833.4 892.4 940.3 985.4 26583.5 26616.3 26799.9 27243.3 27422.9 927.4 945.6 971.2 1022.7 1022.8 13884.0 14251.7 14508.3 14512.9 14522.3 355054.0 361200.0 363939.0 364072.0 364347.0 49236.5 50639.7 50703.5 50704.5 50724.2 995.9 1161.8 1203.4 1240.1 1249.1 24521.0 26767.0 27135.3 27188.0 27350.9 39367.0 39628.6 39848.4 40043.0 40209.6 225549.0 228528.0 228974.0 229557.0 229653.0 22690.5 24944.9 25457.0 25476.4 25567.1 39302.4 39942.2 40272.2 40571.0 40573.6 34292.7 35078.3 35154.3 35694.6 35830.8 34742.3 34942.0 35104.8 35433.5 35515.5 32234.5 32290.0 32531.7 32942.7 32988.8 30828.0 32144.5 32161.8 32232.8 32318.7 22672.2 23091.9 23306.8 23371.9 23420.9 12:09:00 INFO - PROCESS | 18103 | 12:09:00 INFO - PROCESS | 18103 | [#2] jquery.html Cycles:180 Average:23231.84 Median:4367.69 stddev:63052.11 (1443.6%) stddev-sans-first:63205.62 12:09:00 INFO - PROCESS | 18103 | Values: 370.8 381.0 383.6 386.3 386.3 16202.4 16271.8 17192.0 17240.4 17241.9 15218.6 15226.8 15903.4 15929.7 15955.3 4444.6 4595.8 4627.7 4629.4 4631.3 3417.8 5055.5 5373.6 5383.0 5386.6 5349.7 5356.3 5358.5 5370.5 5375.2 5047.9 5370.1 5374.9 5375.4 5381.6 3367.2 3572.5 3577.6 3577.7 4938.6 11945.8 12109.6 12158.8 12936.5 18934.2 1895.5 1977.9 1991.9 2033.0 2471.0 8624.4 8676.0 9149.2 11067.3 13481.6 1697.4 1727.0 1732.2 1752.5 1826.9 67522.7 71661.0 71698.6 71861.0 73173.0 9724.2 9887.8 9954.7 10096.8 10137.9 13904.2 14018.7 14042.4 14055.9 14086.9 6870.8 6993.4 7154.7 7230.4 7244.5 6536.8 6538.9 6552.6 6697.3 6704.5 4074.6 4080.9 4311.4 4339.3 4396.1 1653.0 1735.5 1746.4 1758.9 1782.7 788.7 806.8 859.7 865.8 898.8 14894.9 15652.4 15825.4 16187.1 16259.7 811.8 818.3 824.5 830.4 856.8 8661.9 8674.9 8947.8 9017.2 9190.6 253899.0 402653.0 405782.0 408712.0 409980.0 50734.0 51553.7 79860.2 88141.6 88234.6 993.6 1004.5 1010.1 1044.0 1056.8 14875.9 14876.5 15246.5 15253.0 15334.2 34396.3 34398.7 34627.0 34722.3 35115.8 44390.0 46181.3 47656.5 49001.8 49031.3 6933.4 7623.5 7835.2 7840.7 8057.5 10015.9 11560.7 11568.2 11673.4 11684.9 9366.9 9418.2 9678.4 9878.8 10059.2 9641.9 9932.8 10114.9 10358.2 10512.3 5017.9 6692.8 9006.8 9528.3 10334.2 7666.2 7716.5 7830.3 7843.0 7922.2 9657.1 10059.3 10098.8 10127.9 10389.1 12:09:00 INFO - PROCESS | 18103 | 12:09:00 INFO - PROCESS | 18103 | [#3] mootools.html Cycles:180 Average:5218.61 Median:4802.41 stddev:2937.84 (61.2%) stddev-sans-first:2931.50 12:09:00 INFO - PROCESS | 18103 | Values: 1323.7 1491.3 1499.8 1665.4 1818.0 7607.2 7962.8 7963.2 7971.3 7980.6 7712.0 7860.1 7877.0 7879.8 7884.4 1928.6 2186.1 2206.1 2233.3 2259.4 2252.0 2273.7 2278.2 2278.2 2278.8 2241.4 2278.9 2281.8 2282.1 2285.8 1945.5 2178.5 2253.2 2254.4 2254.7 2178.0 2190.2 2195.6 2197.2 2234.4 7825.2 7870.2 7875.3 7875.4 7876.6 4403.5 4585.3 4604.3 4613.1 4700.1 3046.8 3061.6 3123.9 3140.8 3163.4 943.7 946.6 952.1 957.3 963.3 10710.3 10720.8 10731.6 10747.1 10751.8 4215.3 4295.2 4331.0 4362.3 4379.5 9142.1 9167.6 9185.5 9186.2 9192.8 4013.3 4687.6 4688.4 4689.4 4721.3 4182.8 4255.9 4276.6 4278.2 4302.2 3629.3 3679.3 3732.2 3767.5 3821.4 1174.6 1219.7 1239.1 1254.3 1259.3 819.9 826.6 840.3 852.2 859.1 5058.3 5205.6 5210.0 5359.4 5369.5 433.4 433.4 436.2 439.9 442.4 3519.8 3579.1 3603.0 3630.8 3637.1 9626.8 9900.3 10105.1 10140.3 10145.3 9929.9 9950.1 10030.3 10044.2 10047.1 7392.8 7406.2 7503.5 7565.7 7621.4 5249.8 5474.8 5482.3 5493.8 5739.1 8960.9 8976.1 9037.9 9113.1 9241.9 8451.9 9226.4 9238.4 9249.4 9255.2 6182.0 6735.7 6793.1 6949.3 7006.4 7560.1 7574.7 7641.0 7642.4 7674.0 6429.5 6657.7 6711.1 6788.7 6897.7 6625.2 6650.9 6702.4 6718.7 6731.8 6403.4 6406.2 6474.7 6475.2 6486.6 4729.1 4799.5 4833.4 4869.7 4881.1 4618.9 4734.4 4743.7 4805.3 4818.0 12:09:00 INFO - PROCESS | 18103 | 12:09:00 INFO - PROCESS | 18103 | [#4] prototype.html Cycles:180 Average:4377.23 Median:4975.98 stddev:1266.24 (25.4%) stddev-sans-first:1232.55 12:09:00 INFO - PROCESS | 18103 | Values: 315.9 321.2 324.5 327.8 327.9 4669.9 4780.9 5012.7 5050.5 5050.8 4960.2 4966.4 4985.6 5003.9 5007.1 3974.5 3992.2 3997.7 3999.4 4003.9 3762.3 3819.2 3967.7 3987.5 3989.7 3931.7 3943.3 3944.9 3953.1 3967.1 3913.5 3930.7 3935.6 3952.4 3958.5 3516.3 3526.6 3529.4 3530.0 3539.5 4588.7 4816.9 4822.4 4836.2 4842.0 4440.0 4441.7 4454.7 4455.2 4459.4 5018.4 5234.8 5286.0 5292.6 5296.8 3728.6 3748.1 3750.4 3750.5 3756.9 5175.0 5311.7 5456.3 5503.0 5528.9 3813.2 3813.5 3825.1 3825.2 3826.3 3858.5 3867.1 3878.8 3883.1 3886.0 4406.8 4417.2 4431.4 4438.4 4442.5 5159.8 5241.8 5260.8 5261.0 5278.3 1308.3 1315.7 1318.0 1322.2 1326.3 887.9 906.4 921.3 922.6 928.2 4587.3 4620.6 4642.1 4645.9 4658.0 5418.0 5426.2 5436.7 5447.2 5492.6 4506.6 4608.2 4608.6 4615.5 4619.0 2891.5 2895.3 2915.4 2917.1 2926.1 5113.6 5123.5 5146.5 5157.3 5160.6 5340.9 5538.5 5553.7 5585.6 5603.7 5093.4 5107.3 5142.5 5143.6 5154.5 5416.6 5450.9 5454.4 5462.1 5464.0 5182.7 5258.9 5303.5 5330.4 5339.9 4905.1 4966.4 5122.0 5159.4 5193.2 3869.4 3877.9 3886.4 3886.8 3890.7 5452.8 5456.6 5499.3 5503.0 5509.4 5015.7 5315.5 5318.3 5322.8 5331.9 5300.3 5301.4 5307.2 5317.4 5319.3 5191.6 5198.4 5208.1 5210.9 5222.1 5051.8 5331.9 5369.4 5371.4 5375.9 5213.3 5232.9 5244.8 5245.2 5260.9 12:09:00 INFO - PROCESS | 18103 | 12:09:00 INFO - PROCESS | 18103 | [#5] yui.html Cycles:180 Average:12583.05 Median:44609.27 stddev:13818.87 (31.0%) stddev-sans-first:13828.50 12:09:00 INFO - PROCESS | 18103 | Values: 634.2 687.4 778.5 794.5 811.7 12212.1 12343.1 12378.3 12380.1 12393.4 12776.6 12841.2 12849.6 12859.5 12905.2 647.3 805.9 836.7 843.0 843.1 825.7 830.1 833.2 834.7 834.8 882.1 884.7 885.4 885.7 885.8 686.5 854.2 880.4 881.8 882.2 646.8 647.4 648.6 648.8 648.9 12786.6 12839.9 12846.1 12846.9 12849.4 12307.3 12693.9 12720.2 12790.6 12916.4 9748.6 9783.2 9961.9 10076.0 10340.3 4200.6 4221.4 4242.7 4267.2 4410.2 45488.8 45785.5 46055.8 46148.5 46152.1 9342.4 9437.4 9447.7 9463.9 9718.7 16835.5 17456.7 17477.9 17503.3 17504.7 6557.6 6867.1 6916.1 6927.2 7003.6 3746.3 3777.2 3805.8 3837.7 3969.3 2904.3 3016.0 3026.7 3059.3 3059.8 469.6 566.0 584.3 585.7 610.2 570.2 598.3 615.4 617.7 645.4 7970.0 8205.1 8269.3 8281.3 8574.4 458.6 542.0 614.8 615.6 624.7 3668.4 3813.4 3844.1 3861.8 3933.8 48729.3 50590.2 50694.7 50725.5 56607.4 43578.6 43982.6 43994.3 44169.0 45049.5 35354.1 37523.6 39219.4 41170.1 42670.8 8232.0 8297.3 8679.6 8697.8 8888.3 25517.2 26200.2 26543.9 27547.4 27809.6 35225.6 36531.8 36596.3 37164.4 37436.0 10817.7 10841.2 10871.5 10992.1 11055.8 11824.7 12084.8 12089.9 12115.0 12270.0 11381.7 11518.9 11568.1 11618.9 12124.6 10584.6 10832.4 11180.8 11436.9 11465.3 11711.6 11719.1 11784.7 12111.3 12128.6 8786.1 8881.2 9461.0 9477.0 9485.1 9305.6 9377.0 9483.3 9520.5 9703.4 12:09:00 INFO - PROCESS | 18103 | -------- Summary: end -------- 12:09:00 INFO - PROCESS | 18103 | 12:09:01 INFO - TEST-INFO | 18103: exit 0 12:09:01 INFO - TEST-OK | dromaeo_css | took 1117666ms 12:09:01 INFO - TEST-START | kraken 12:09:01 INFO - operating with platform_type : linux_ 12:09:01 INFO - Initialising browser for kraken test... 12:09:01 INFO - TEST-INFO | started process 18283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYF7mv7/profile http://localhost:48219/getInfo.html) 12:09:06 INFO - PROCESS | 18283 | __metrics Screen width/height:1600/1200 12:09:06 INFO - PROCESS | 18283 | colorDepth:24 12:09:06 INFO - PROCESS | 18283 | Browser inner width/height: 1024/697 12:09:06 INFO - PROCESS | 18283 | __metrics 12:09:07 ERROR - PROCESS | 18283 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:09:08 INFO - TEST-INFO | 18283: exit 0 12:09:08 INFO - Browser initialized. 12:09:08 INFO - Running cycle 1/1 for kraken test... 12:09:08 INFO - TEST-INFO | started process 18364 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYF7mv7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:09:20 INFO - PROCESS | 18364 | RSS: Main: 155078656 12:09:20 INFO - PROCESS | 18364 | 12:09:22 INFO - PROCESS | 18364 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48219/tests/kraken/driver.html?testName=audio-beat-detection) 12:09:23 INFO - PROCESS | 18364 | RSS: Main: 210157568 12:09:23 INFO - PROCESS | 18364 | 12:09:26 INFO - PROCESS | 18364 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48219/tests/kraken/driver.html?testName=audio-dft) 12:09:27 INFO - PROCESS | 18364 | RSS: Main: 196337664 12:09:27 INFO - PROCESS | 18364 | 12:09:30 INFO - PROCESS | 18364 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48219/tests/kraken/driver.html?testName=audio-fft) 12:09:30 INFO - PROCESS | 18364 | RSS: Main: 266817536 12:09:30 INFO - PROCESS | 18364 | 12:09:32 INFO - PROCESS | 18364 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48219/tests/kraken/driver.html?testName=audio-oscillator) 12:09:33 INFO - PROCESS | 18364 | RSS: Main: 174292992 12:09:33 INFO - PROCESS | 18364 | 12:09:35 INFO - PROCESS | 18364 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48219/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:09:36 INFO - PROCESS | 18364 | RSS: Main: 178667520 12:09:36 INFO - PROCESS | 18364 | 12:09:39 INFO - PROCESS | 18364 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48219/tests/kraken/driver.html?testName=imaging-darkroom) 12:09:40 INFO - PROCESS | 18364 | RSS: Main: 215109632 12:09:40 INFO - PROCESS | 18364 | 12:09:43 INFO - PROCESS | 18364 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48219/tests/kraken/driver.html?testName=imaging-desaturate) 12:09:44 INFO - PROCESS | 18364 | RSS: Main: 215564288 12:09:44 INFO - PROCESS | 18364 | 12:09:47 INFO - PROCESS | 18364 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48219/tests/kraken/driver.html?testName=json-parse-financial) 12:09:47 INFO - PROCESS | 18364 | RSS: Main: 215773184 12:09:47 INFO - PROCESS | 18364 | 12:09:49 INFO - PROCESS | 18364 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48219/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:09:50 INFO - PROCESS | 18364 | RSS: Main: 201105408 12:09:50 INFO - PROCESS | 18364 | 12:09:51 INFO - PROCESS | 18364 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:09:52 INFO - PROCESS | 18364 | RSS: Main: 203608064 12:09:52 INFO - PROCESS | 18364 | 12:09:54 INFO - PROCESS | 18364 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:09:55 INFO - PROCESS | 18364 | RSS: Main: 220684288 12:09:55 INFO - PROCESS | 18364 | 12:09:58 INFO - PROCESS | 18364 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:09:58 INFO - PROCESS | 18364 | RSS: Main: 224251904 12:09:58 INFO - PROCESS | 18364 | 12:10:01 INFO - PROCESS | 18364 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:10:02 INFO - PROCESS | 18364 | RSS: Main: 219361280 12:10:02 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | Cycle 1(1): loaded http://localhost:48219/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48219/tests/kraken/driver.html?testName=ai-astar) 12:10:04 INFO - PROCESS | 18364 | RSS: Main: 282656768 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | __start_tp_report 12:10:04 INFO - PROCESS | 18364 | _x_x_mozilla_page_load 12:10:04 INFO - PROCESS | 18364 | _x_x_mozilla_page_load_details 12:10:04 INFO - PROCESS | 18364 | |i|pagename|runs| 12:10:04 INFO - PROCESS | 18364 | |0;ai-astar;110;112;106;110;114;111;102;112;112;111 12:10:04 INFO - PROCESS | 18364 | |1;audio-beat-detection;155;132;153;185;131;166;172;134;194;133 12:10:04 INFO - PROCESS | 18364 | |2;audio-dft;161;160;162;163;162;175;162;161;163;161 12:10:04 INFO - PROCESS | 18364 | |3;audio-fft;75;74;113;110;74;76;77;125;100;75 12:10:04 INFO - PROCESS | 18364 | |4;audio-oscillator;103;97;148;94;95;95;144;96;93;144 12:10:04 INFO - PROCESS | 18364 | |5;imaging-gaussian-blur;118;117;116;117;116;117;117;117;117;116 12:10:04 INFO - PROCESS | 18364 | |6;imaging-darkroom;146;146;147;146;147;145;146;146;146;147 12:10:04 INFO - PROCESS | 18364 | |7;imaging-desaturate;95;96;95;95;96;96;95;95;96;94 12:10:04 INFO - PROCESS | 18364 | |8;json-parse-financial;63;69;63;63;64;64;64;82;63;63 12:10:04 INFO - PROCESS | 18364 | |9;json-stringify-tinderbox;65;64;64;64;64;64;64;65;64;65 12:10:04 INFO - PROCESS | 18364 | |10;stanford-crypto-aes;85;84;83;84;85;85;84;85;85;84 12:10:04 INFO - PROCESS | 18364 | |11;stanford-crypto-ccm;146;139;136;136;135;135;138;138;168;138 12:10:04 INFO - PROCESS | 18364 | |12;stanford-crypto-pbkdf2;171;170;176;176;171;176;170;172;176;171 12:10:04 INFO - PROCESS | 18364 | |13;stanford-crypto-sha256-iterative;72;75;73;71;70;70;70;69;71;74 12:10:04 INFO - PROCESS | 18364 | __end_tp_report 12:10:04 INFO - PROCESS | 18364 | __start_cc_report 12:10:04 INFO - PROCESS | 18364 | _x_x_mozilla_cycle_collect,1876 12:10:04 INFO - PROCESS | 18364 | __end_cc_report 12:10:04 INFO - PROCESS | 18364 | __startTimestamp1460574604323__endTimestamp 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | ------- Summary: start ------- 12:10:04 INFO - PROCESS | 18364 | Number of tests: 14 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.50 stddev:3.50 (3.1%) stddev-sans-first:3.71 12:10:04 INFO - PROCESS | 18364 | Values: 110.0 112.0 106.0 110.0 114.0 111.0 102.0 112.0 112.0 111.0 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | [#1] audio-beat-detection Cycles:10 Average:155.50 Median:160.50 stddev:23.24 (14.5%) stddev-sans-first:24.65 12:10:04 INFO - PROCESS | 18364 | Values: 155.0 132.0 153.0 185.0 131.0 166.0 172.0 134.0 194.0 133.0 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.00 stddev:4.32 (2.7%) stddev-sans-first:4.52 12:10:04 INFO - PROCESS | 18364 | Values: 161.0 160.0 162.0 163.0 162.0 175.0 162.0 161.0 163.0 161.0 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | [#3] audio-fft Cycles:10 Average:89.90 Median:74.50 stddev:19.95 (26.8%) stddev-sans-first:20.42 12:10:04 INFO - PROCESS | 18364 | Values: 75.0 74.0 113.0 110.0 74.0 76.0 77.0 125.0 100.0 75.0 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | [#4] audio-oscillator Cycles:10 Average:110.90 Median:94.50 stddev:23.94 (25.3%) stddev-sans-first:25.22 12:10:04 INFO - PROCESS | 18364 | Values: 103.0 97.0 148.0 94.0 95.0 95.0 144.0 96.0 93.0 144.0 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 12:10:04 INFO - PROCESS | 18364 | Values: 118.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 12:10:04 INFO - PROCESS | 18364 | Values: 146.0 146.0 147.0 146.0 147.0 145.0 146.0 146.0 146.0 147.0 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 12:10:04 INFO - PROCESS | 18364 | Values: 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 94.0 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:64.00 stddev:5.98 (9.3%) stddev-sans-first:6.25 12:10:04 INFO - PROCESS | 18364 | Values: 63.0 69.0 63.0 63.0 64.0 64.0 64.0 82.0 63.0 63.0 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 12:10:04 INFO - PROCESS | 18364 | Values: 65.0 64.0 64.0 64.0 64.0 64.0 64.0 65.0 64.0 65.0 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 12:10:04 INFO - PROCESS | 18364 | Values: 85.0 84.0 83.0 84.0 85.0 85.0 84.0 85.0 85.0 84.0 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:138.00 stddev:10.04 (7.3%) stddev-sans-first:10.48 12:10:04 INFO - PROCESS | 18364 | Values: 146.0 139.0 136.0 136.0 135.0 135.0 138.0 138.0 168.0 138.0 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:174.00 stddev:2.73 (1.6%) stddev-sans-first:2.80 12:10:04 INFO - PROCESS | 18364 | Values: 171.0 170.0 176.0 176.0 171.0 176.0 170.0 172.0 176.0 171.0 12:10:04 INFO - PROCESS | 18364 | 12:10:04 INFO - PROCESS | 18364 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:1.96 (2.7%) stddev-sans-first:2.07 12:10:04 INFO - PROCESS | 18364 | Values: 72.0 75.0 73.0 71.0 70.0 70.0 70.0 69.0 71.0 74.0 12:10:04 INFO - PROCESS | 18364 | -------- Summary: end -------- 12:10:04 INFO - PROCESS | 18364 | 12:10:05 INFO - TEST-INFO | 18364: exit 0 12:10:05 INFO - TEST-OK | kraken | took 63812ms 12:10:05 INFO - SUITE-END | took 1181s 12:10:05 INFO - Completed test suite (00:19:41) 12:10:05 INFO - javascript benchmark 12:10:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2594.7275536068714, 2677.370817857803, 2683.2889284339667, 2699.3926366567525, 2719.7552220300167, 4499.842505512308, 4593.448786145659, 4641.791119399627, 4650.8837279068, 4660.370849935262, 4598.057398233363, 4613.215753321935, 4625.999999999992, 4680.625549956004, 4697.013627138305, 4218.91562168758, 4242.087951090522, 4271.551487093857, 4302.204092242945, 4413.051193993291, 4336.84821031264, 4362.5637436256275, 4378.365137055125, 4384.276594361926, 4404.537523560028, 4140.3375459926565, 4230.661547076226, 4245.299525578307, 4248.660107191417, 4316.805743741539, 4246.278132717445, 4262.509811371701, 4263.040815816447, 4265.957340426618, 4301.956980430187, 4242.660587153051, 4245.15096980602, 4249.150169966019, 4276.31578947367, 4280.101178752466, 4424.579664931826, 4492.483364413069, 4523.7285762854335, 4574.451065872084, 4585.862424127282, 4959.404871415417, 4975.378077740283, 4988.176950803113, 4993.0263598598285, 5014.674046187022, 4871.196252618313, 4994.950050499521, 4996.775145118479, 5002.0, 5003.874903127451, 4643.0, 4685.0, 4686.929696054562, 4731.550502702238, 4734.289856521515, 5084.084864724311, 5144.125498665236, 5144.125498665236, 5147.3051138096625, 5198.376194856642, 4737.194676904865, 4841.661083724105, 4920.286558449005, 4926.0, 4937.679050861682, 4958.727270000185, 4980.5019498049905, 4981.4769449207315, 4993.800247990112, 5031.371078615173, 4912.214045752662, 4926.088673595396, 4935.481774413634, 4937.506249375106, 4979.90040199194, 4770.522947705202, 4909.803607855646, 4911.189653707098, 4968.9316796888115, 4968.975155124202, 4193.685473589432, 4196.28663127263, 4196.328587425997, 4225.408442818008, 4225.978870105691, 3662.487251784752, 3688.944665830015, 3691.0218792020137, 3723.590405055442, 3729.701623870084, 4153.958460415357, 4193.622573968358, 4227.492700875853, 4255.893602659897, 4260.552641972548, 5009.348784657971, 5016.949830501649, 5017.122003649347, 5025.045241404122, 5025.346704928336, 4295.22685916538, 4295.591918767712, 4298.570142985676, 4321.891952701145, 4341.0232697643405, 4340.565943405634, 4426.84506042287, 4480.529544397857, 4482.125985432875, 4515.0518391137575, 4690.179218636725, 4694.084653492673, 4712.340272361941, 4712.85861424151, 4759.2147295697205, 4971.105201063843, 4983.700977941335, 4984.376952880745, 4984.426790918946, 5034.924476132787, 4604.907901841877, 4715.717056976455, 4756.025014871874, 4757.0, 4801.639877009168, 4876.390451193601, 4877.268409738567, 4896.779644916059, 4897.926531101965, 4949.356583644103, 4783.689060211075, 4954.355933728736, 4969.0807200668, 4969.503049695146, 5019.723915184554, 4852.417709874838, 4896.2655601660035, 4896.485868983706, 4898.044881248123, 4939.75301234944, 4822.734749588806, 4867.780949857194, 4867.95132048675, 4870.928395752929, 4918.385201849769, 4629.907401852011, 4697.882552936204, 4765.809367625395, 4776.9761151194025, 4825.9034819304115, 4855.150348689036, 4876.0, 4884.12085824555, 4899.975500122477, 4927.433345165352, 4773.188557945088, 4777.8327758528285, 4780.832670856643, 4785.760711964457, 4833.081714474239], "value": 4568.798828185244, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.0769288370815, 593.1695626123428, 617.2253821454076, 620.6648409858676, 646.237439821011, 26884.19347419578, 27576.44847103059, 34155.82922085389, 35220.647793522054, 35249.823750881274, 37418.4387234191, 38257.23485530288, 38279.23441531168, 38383.42424863629, 38418.0, 7540.8114797129965, 7747.845043099134, 7751.573663448508, 7754.883676744853, 7755.612219389036, 7610.1628820829665, 7645.120811106738, 7707.267809558083, 7731.342835858959, 7732.884006739903, 7603.391728661693, 7694.230576942317, 7799.844003119934, 7840.921590784104, 7850.371970242395, 7814.374850012014, 7877.369810415153, 7882.290593846553, 7885.487443316195, 7886.881696774553, 7761.534307941542, 7847.6860925562905, 7871.0, 7873.763787086396, 7876.80307992299, 37697.0, 38033.23933521314, 38259.0, 38290.42564361537, 38298.0, 3162.58886344776, 3178.4596618574897, 3198.9680103198903, 3281.064896504509, 3293.5883014623173, 28795.28011799701, 28867.711322886713, 28876.855615721997, 28935.56596651052, 29741.553876691865, 3044.680308567613, 3064.0960916529675, 3079.907602771898, 3101.379724055198, 3165.0346644273486, 240010.0, 240745.0, 240861.0, 240939.0, 241305.0, 48822.0, 50665.0, 50829.49170508247, 50857.74571127121, 50866.0, 57896.42103578994, 59537.40462595318, 60147.69926150341, 60244.0, 60315.0, 12786.168899021533, 13025.088243822842, 13033.348332583522, 13042.087053906136, 13042.739145217232, 9631.277654175965, 9674.516274186262, 9722.125008749246, 9726.902730972599, 9731.708048758548, 17624.0, 17636.647267054843, 17752.733708994376, 18348.08259587042, 18425.07874606264, 6762.7394741312655, 6949.82625434358, 7022.1924478685605, 7154.427645788324, 7270.8182295441975, 821.9630116644765, 833.4249367936104, 892.3887137310962, 940.2732076976822, 985.4186030242191, 26583.468330633666, 26616.334591635365, 26799.86600066987, 27243.318917027234, 27422.862885685445, 927.4342650982895, 945.6170251048336, 971.2424309038961, 1022.6983040003217, 1022.8056669232822, 13884.0, 14251.714965700628, 14508.347124379428, 14512.85487145115, 14522.273886305642, 355054.0, 361200.0, 363939.0, 364072.0, 364347.0, 49236.50763492319, 50639.7468012665, 50703.49296507062, 50704.49295507072, 50724.23913641298, 995.875515560555, 1161.7792619402287, 1203.4043148641479, 1240.094730846469, 1249.0632025980333, 24521.0, 26767.0, 27135.321616959733, 27188.0, 27350.863245683646, 39367.0, 39628.60371396249, 39848.40227396534, 40043.0, 40209.597904020586, 225549.0, 228528.0, 228974.0, 229557.0, 229653.0, 22690.546189076456, 24944.875275623504, 25457.0, 25476.363090922874, 25567.105151319614, 39302.41046384249, 39942.20115597614, 40272.1945561093, 40571.0, 40573.59426405816, 34292.65707342895, 35078.29843403168, 35154.296914061066, 35694.64305356913, 35830.82084589665, 34742.30515389729, 34942.0, 35104.82447587746, 35433.46849797203, 35515.46726799048, 32234.516482252315, 32290.0, 32531.674683252866, 32942.67057329396, 32988.835055824566, 30828.0, 32144.517832233003, 32161.839190803898, 32232.83883580567, 32318.676813231566, 22672.206472774033, 23091.88454057719, 23306.766932330458, 23371.88314058419, 23420.88289558541], "value": 16836.24733917544, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.79791513625054, 380.95618006661755, 383.64512825636314, 386.2526012166458, 386.2622391232746, 16202.351905923764, 16271.83728162718, 17192.0, 17240.396586119456, 17241.913790431045, 15218.619534511643, 15226.771598426005, 15903.363865445397, 15929.681406371865, 15955.282012309444, 4444.622207112399, 4595.793189306489, 4627.699199552035, 4629.444466663988, 4631.328457373679, 3417.7607567470286, 5055.46917573655, 5373.623846330758, 5383.0, 5386.622936394454, 5349.679019258838, 5356.250124982505, 5358.490943360374, 5370.516653501184, 5375.247465354853, 5047.949520504784, 5370.113931201347, 5374.91937620936, 5375.354957405098, 5381.596380271495, 3367.2255381262203, 3572.464130380438, 3577.606463289036, 3577.695895848856, 4938.555530002282, 11945.761084778344, 12109.636710898687, 12158.817617735742, 12936.547220847318, 18934.24263029477, 1895.5261184703825, 1977.8615496915222, 1991.9203231870708, 2032.9530291899684, 2471.0486462711983, 8624.353173512012, 8675.95662021692, 9149.176574108296, 11067.335959842436, 13481.59555213345, 1697.3719723702309, 1726.9827301727073, 1732.2205007746566, 1752.4830175098377, 1826.8538516918748, 67522.66238668824, 71661.0, 71698.64150679266, 71861.0, 73173.0, 9724.222062235005, 9887.80224395508, 9954.701358959099, 10096.798064038678, 10137.949310253549, 13904.165750055028, 14018.719625607635, 14042.438302467786, 14055.859441405659, 14086.929565352108, 6870.828229294308, 6993.440524758007, 7154.749583764543, 7230.385417239593, 7244.49288549807, 6536.7712130075215, 6538.901916471256, 6552.6068435894, 6697.330266973264, 6704.463642908653, 4074.5517993020744, 4080.8571699990357, 4311.374850646639, 4339.284018136972, 4396.098799746108, 1652.983470165307, 1735.488031030849, 1746.3974928649595, 1758.903260320669, 1782.6969415199446, 788.7278888783361, 806.7741032510907, 859.7291853066264, 865.7575878753959, 898.7528429681889, 14894.851051489562, 15652.37390504367, 15825.446109386115, 16187.10970896612, 16259.674806503805, 811.7564730580921, 818.2594751749676, 824.4599787139433, 830.3689196210923, 856.8157846063126, 8661.913380866237, 8674.86987695185, 8947.821043579092, 9017.188453039258, 9190.632374704937, 253899.0, 402653.0, 405782.0, 408712.0, 409980.0, 50734.0, 51553.742231288605, 79860.20139798528, 88141.55929220314, 88234.55882720546, 993.562832353762, 1004.4877112672443, 1010.0909181736349, 1043.984340234897, 1056.75166335911, 14875.925620371829, 14876.479323223635, 15246.466373676869, 15253.0, 15334.156621385484, 34396.31207375888, 34398.65601343955, 34627.0, 34722.305553888276, 35115.82442087773, 44390.0, 46181.30728039149, 47656.52343476521, 49001.754991224814, 49031.26453103135, 6933.445324374139, 7623.542587444771, 7835.177306382976, 7840.686372545262, 8057.476264042818, 10015.899841001497, 11560.6531804046, 11568.190226684052, 11673.357965311989, 11684.88315116838, 9366.859497107413, 9418.152366286793, 9678.419294842332, 9878.75303117399, 10059.245556583139, 9641.903580964381, 9932.751681208028, 10114.949425252827, 10358.171346292127, 10512.264141510326, 5017.899642007213, 6692.799216023527, 9006.819863602823, 9528.333016688764, 10334.224933129895, 7666.19504951972, 7716.5370077795515, 7830.295273425191, 7842.980412546332, 7922.247386498273, 9657.130858222794, 10059.346142500714, 10098.798024039625, 10127.949360253151, 10389.116925061153], "value": 7836.311373923347, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.6889331007217, 1491.2635314198449, 1499.8050253467047, 1665.4110392105017, 1818.045526098798, 7607.1632120466775, 7962.840743185133, 7963.2036796320335, 7971.322437592811, 7980.561069141202, 7712.0, 7860.135385107634, 7876.960615196916, 7879.842403151948, 7884.369250459964, 1928.633559623674, 2186.1036974840317, 2206.09550084465, 2233.2630232023475, 2259.378670865509, 2252.042881775247, 2273.7044184256024, 2278.236790675126, 2278.236790675126, 2278.760730123338, 2241.4060274027397, 2278.874661893595, 2281.7946384825364, 2282.1327895399727, 2285.8399912006166, 1945.4552725236886, 2178.4989452425953, 2253.2451628704403, 2254.447660323215, 2254.6505291679814, 2178.0198910490344, 2190.233418303597, 2195.6157672407426, 2197.1540956731615, 2234.441389652587, 7825.178356272566, 7870.212978702084, 7875.291223789829, 7875.4487185897015, 7876.5667888266125, 4403.471583409979, 4585.266357382836, 4604.263317869125, 4613.100445413146, 4700.059988002413, 3046.817190968549, 3061.6172978377704, 3123.875044998197, 3140.78574604903, 3163.43058249515, 943.7310366545502, 946.6118891254622, 952.0669743651191, 957.3059531839431, 963.2919803944095, 10710.250282480307, 10720.78558428835, 10731.624393146203, 10747.140228781678, 10751.83872241917, 4215.3044747616295, 4295.205387003414, 4330.999999999937, 4362.258416069276, 4379.49635791888, 9142.131497507726, 9167.633294668138, 9185.540722963826, 9186.219171370374, 9192.770180745534, 4013.2776100301644, 4687.554682305175, 4688.390509233778, 4689.3903792507435, 4721.3390125382475, 4182.790860456965, 4255.893602659959, 4276.615104640598, 4278.165757677285, 4302.182585308781, 3629.292288003867, 3679.300932822755, 3732.1975775207916, 3767.453719210699, 3821.4267859820693, 1174.5536696055615, 1219.725561748617, 1239.1449899569268, 1254.2913254011455, 1259.2696236182992, 819.8852160697508, 826.6321486938255, 840.2983508770124, 852.1648784191527, 859.0679113162164, 5058.317127187856, 5205.6356055075785, 5209.984053109683, 5359.383670877821, 5369.463053694677, 433.36944745396005, 433.427875204733, 436.151684972725, 439.94720633524184, 442.38066706610357, 3519.824008799601, 3579.069441945113, 3602.963970360315, 3630.7821530708243, 3637.0907273181706, 9626.807463850684, 9900.306978511435, 10105.090541851268, 10140.29017968735, 10145.28982971185, 9929.851052234222, 9950.10449059588, 10030.29787914839, 10044.246681498917, 10047.145992590566, 7392.778216653509, 7406.185319614838, 7503.549787012906, 7565.6973721051645, 7621.352185064332, 5249.842504724865, 5474.835754927359, 5482.342118945752, 5493.780248790164, 5739.110437882135, 8960.865587016331, 8976.102389760972, 9037.864432033657, 9113.134252246025, 9241.907580924104, 8451.873221901553, 9226.40028398152, 9238.445693258425, 9249.352545321763, 9255.213306868991, 6182.0, 6735.730570777114, 6793.116894803644, 6949.270326615632, 7006.369426751617, 7560.092788865151, 7574.697012119454, 7640.961795190989, 7642.388608911163, 7674.040744906887, 6429.51778616615, 6657.73369065232, 6711.060451536691, 6788.7284508619105, 6897.655117244218, 6625.236044641193, 6650.866982660416, 6702.36327548882, 6718.664066796543, 6731.79804605843, 6403.423691867754, 6406.231252249573, 6474.741010359533, 6475.1582294303325, 6486.643234622141, 4729.101470720552, 4799.520047995173, 4833.419989601271, 4869.659123861437, 4881.121398148367, 4618.884527886829, 4734.431868175841, 4743.66794324394, 4805.303231031551, 4818.012307476889], "value": 4142.022658794261, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.8720718109165, 321.1793866670656, 324.4532961959099, 327.80004197439575, 327.89507357645533, 4669.9066018679605, 4780.8565743027675, 5012.674176178551, 5050.46970068143, 5050.84847454576, 4960.206366981275, 4966.354373931384, 4985.551300382965, 5003.899922001567, 5007.148784706599, 3974.4833171687715, 3992.2414741199223, 3997.6601988830985, 3999.4200840878057, 4003.939940900889, 3762.341590221714, 3819.178876541543, 3967.662748666367, 3987.5414327352437, 3989.740666856645, 3931.7444366116256, 3943.3296339622334, 3944.881653550398, 3953.0907891185043, 3967.0875698589343, 3913.5499417566916, 3930.6658933990643, 3935.626115519021, 3952.426898099788, 3958.4853968984135, 3516.3318969395987, 3526.6297038811067, 3529.3823580873245, 3529.9647003529894, 3539.50446937429, 4588.678792484528, 4816.927746083811, 4822.397200349957, 4836.226203807374, 4842.0, 4439.955600443986, 4441.711288766252, 4454.710443821141, 4455.242608756519, 4459.420275364214, 5018.422881368653, 5234.790608375661, 5285.995660824431, 5292.57659387252, 5296.814611488579, 3728.6271372862766, 3748.137928276484, 3750.4186851038135, 3750.474933509311, 3756.868509602178, 5174.97412512935, 5311.7344132793205, 5456.345238571397, 5503.0, 5528.861778455531, 3813.199228162117, 3813.485179500732, 3825.101101241206, 3825.1775868187915, 3826.253880493333, 3858.479105320802, 3867.149227170018, 3878.84484620612, 3883.0874744435037, 3885.96114038856, 4406.801693923781, 4417.1668757465295, 4431.357453169272, 4438.379991303151, 4442.511758560854, 5159.813242954142, 5241.816536421207, 5260.842614624777, 5260.973695131576, 5278.313819203479, 1308.3327502973552, 1315.7302752935625, 1317.9604611861469, 1322.213283096556, 1326.270551196838, 887.8801361816202, 906.3655441191192, 921.2906062331967, 922.5617831530104, 928.1739252065667, 4587.266037433995, 4620.561046700558, 4642.141203877293, 4645.883852903637, 4657.953420465819, 5417.972910135424, 5426.213199086111, 5436.673799572039, 5447.1829225616475, 5492.588055895823, 4506.594406503365, 4608.193566125915, 4608.585227329557, 4615.538446155425, 4618.976905115453, 2891.465078960357, 2895.3340731631843, 2915.3877685686243, 2917.0519581136214, 2926.0929111975356, 5113.571053749513, 5123.487651234846, 5146.536811686966, 5157.329547158845, 5160.561352285023, 5340.866478338073, 5538.47384498472, 5553.694546799884, 5585.609007369527, 5603.691796951125, 5093.414257360377, 5107.336046313955, 5142.534377702337, 5143.588512918957, 5154.484551544891, 5416.647917885325, 5450.874159077884, 5454.372747134131, 5462.126059830408, 5464.0, 5182.714950677749, 5258.921116183337, 5303.549198318186, 5330.387005494418, 5339.917432201367, 4905.1416002200185, 4966.404031516241, 5121.9743901281745, 5159.355080614923, 5193.182386164963, 3869.438931354994, 3877.9418308724826, 3886.3587508060855, 3886.84452621892, 3890.669293110004, 5452.781888724407, 5456.590755693418, 5499.312585926759, 5503.0, 5509.393966663583, 5015.749212539431, 5315.495027972336, 5318.308619879391, 5322.760475778522, 5331.866703332447, 5300.31095957523, 5301.416844147064, 5307.203919412119, 5317.361916570037, 5319.335083114611, 5191.610629202901, 5198.402183748917, 5208.114620514598, 5210.8957820844125, 5222.138347172674, 5051.823186188466, 5331.88030513581, 5369.409364969928, 5371.355437347544, 5375.865603359947, 5213.322268105122, 5232.869178270574, 5244.7639856207325, 5245.160774276097, 5260.921086183634], "value": 3978.4284333472656, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.1629049654458, 687.3744892148145, 778.4511919097035, 794.51534563916, 811.7037281392294, 12212.145149839504, 12343.13598048137, 12378.319192444413, 12380.071494637894, 12393.38033098345, 12776.616701498946, 12841.229526228433, 12849.614511564645, 12859.485620575166, 12905.1611645243, 647.2621211818507, 805.9032916050082, 836.7322456813807, 843.0305149078578, 843.0852525010371, 825.694493037577, 830.1490971753971, 833.212614079695, 834.6744769539885, 834.7746108550688, 882.1487264789477, 884.725735022142, 885.3536918049828, 885.6944354197824, 885.7829831691245, 686.5194363945259, 854.218390172991, 880.3969281042506, 881.7971866470748, 882.1707594860875, 646.7703965092419, 647.3914520350855, 648.5719425179359, 648.8313038609948, 648.8572514046903, 12786.61640150797, 12839.871601284054, 12846.100772945898, 12846.935765321114, 12849.35753212345, 12307.26156430617, 12693.873061269362, 12720.23678579279, 12790.552330668475, 12916.418761155677, 9748.610055597768, 9783.168430683401, 9961.90038099617, 10076.0, 10340.327878687936, 4200.558941311179, 4221.366794980747, 4242.66058715302, 4267.231898258312, 4410.184115938561, 45488.77255613734, 45785.542144578794, 46055.76972115151, 46148.538514615095, 46152.07695846098, 9342.392744471723, 9437.386569872937, 9447.716568502818, 9463.90536094644, 9718.70843874685, 16835.49493515172, 17456.738148927776, 17477.91261043712, 17503.299868005393, 17504.737428938577, 6557.573757705733, 6867.141607299088, 6916.100906882073, 6927.203371612329, 7003.5797852129035, 3746.3069332173636, 3777.20678657485, 3805.771653700787, 3837.654611085016, 3969.325214713506, 2904.3465220325256, 3015.969840301569, 3026.7124623160767, 3059.265776213693, 3059.7705172111737, 469.61960811742597, 565.9830205093854, 584.2842517915519, 585.748128304833, 610.2189197826789, 570.1675553691574, 598.3119412675371, 615.4184295840478, 617.7004152985799, 645.3868824616633, 7969.965352317926, 8205.138460461685, 8269.255766980881, 8281.29608983231, 8574.442661227, 458.60379517023284, 542.0216509200931, 614.7950017964839, 615.5691016288616, 624.6782906803, 3668.413053911415, 3813.3898576228225, 3844.0774214188395, 3861.787601681878, 3933.842646294116, 48729.269060964114, 50590.24114638283, 50694.74652626713, 50725.492745072814, 56607.43392566022, 43578.564214358084, 43982.56017439849, 43994.34008489875, 44169.0, 45049.549504505194, 35354.116147096014, 37523.62476375256, 39219.41170882439, 41170.05959284905, 42670.78664606657, 8232.0, 8297.294729948022, 8679.566021699016, 8697.826043478968, 8888.333374996771, 25517.23448296554, 26200.213993580222, 26543.867280664246, 27547.44905101927, 27809.58285625677, 35225.64774352223, 36531.81734091313, 36596.268074637825, 37164.44253336148, 37436.0, 10817.729556760829, 10841.241113122005, 10871.51078201467, 10992.120630349713, 11055.83416248773, 11824.704382390164, 12084.75830483403, 12089.879101208875, 12115.0, 12270.0, 11381.658550243506, 11518.884811151782, 11568.132390070947, 11618.88381116178, 12124.636260911833, 10584.576616935545, 10832.350058996486, 11180.776384472427, 11436.94281528587, 11465.254758440675, 11711.648650540497, 11719.06247500215, 11784.70538236551, 12111.283212200602, 12128.575499857816, 8786.077461866413, 8881.245094167069, 9460.95269523648, 9477.0, 9485.098915603006, 9305.582455565302, 9377.0, 9483.28875334339, 9520.47637379923, 9703.417794932328], "value": 6035.438741965747, "unit": "score"}], "name": "dromaeo_css", "value": 6256.137231496259, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 106.0, 110.0, 114.0, 111.0, 102.0, 112.0, 112.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 132.0, 153.0, 185.0, 131.0, 166.0, 172.0, 134.0, 194.0, 133.0], "value": 155.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 163.0, 162.0, 175.0, 162.0, 161.0, 163.0, 161.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 113.0, 110.0, 74.0, 76.0, 77.0, 125.0, 100.0, 75.0], "value": 89.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 97.0, 148.0, 94.0, 95.0, 95.0, 144.0, 96.0, 93.0, 144.0], "value": 110.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 145.0, 146.0, 146.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 63.0, 63.0, 64.0, 64.0, 64.0, 82.0, 63.0, 63.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 139.0, 136.0, 136.0, 135.0, 135.0, 138.0, 138.0, 168.0, 138.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 176.0, 176.0, 171.0, 176.0, 170.0, 172.0, 176.0, 171.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 73.0, 71.0, 70.0, 70.0, 70.0, 69.0, 71.0, 74.0], "value": 71.5, "unit": "score"}], "name": "kraken", "value": 1587.4, "alertThreshold": 2.0}]} 12:10:05 INFO - Return code: 0 12:10:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:10:05 ERROR - # TBPL SUCCESS # 12:10:05 INFO - Running post-action listener: _resource_record_post_action 12:10:05 INFO - Running post-run listener: _resource_record_post_run 12:10:06 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12288; Write bytes: 524644352; Read time: 356; Write time: 745376 12:10:06 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 240345088; Read time: 196; Write time: 473240 12:10:06 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284299264; Read time: 160; Write time: 272136 12:10:06 INFO - Running post-run listener: _upload_blobber_files 12:10:06 INFO - Blob upload gear active. 12:10:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:10:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:10:07 INFO - (blobuploader) - INFO - Open directory for files ... 12:10:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:10:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:10:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:08 INFO - (blobuploader) - INFO - Done attempting. 12:10:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:10:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:10:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:08 INFO - (blobuploader) - INFO - Done attempting. 12:10:08 INFO - (blobuploader) - INFO - Iteration through files over. 12:10:08 INFO - Return code: 0 12:10:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:10:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:10:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e2040e4dbbdc4e8fc43cec79731dee0e61b798719744398d06fb2a888d3a55557cf40158c265fd5d005fe0f2820307c3fd54c24ae0fece816463c8f8545bf0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e076d9d2a1e2e943ae77c6ef493d999ce15324b602c4439739407823d76b2e7e0d62d085ff25c378cb61e2cf0c1e1957d0574131bfadfab93b893cb6cd177e6"} 12:10:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:10:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:10:08 INFO - Contents: 12:10:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e2040e4dbbdc4e8fc43cec79731dee0e61b798719744398d06fb2a888d3a55557cf40158c265fd5d005fe0f2820307c3fd54c24ae0fece816463c8f8545bf0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e076d9d2a1e2e943ae77c6ef493d999ce15324b602c4439739407823d76b2e7e0d62d085ff25c378cb61e2cf0c1e1957d0574131bfadfab93b893cb6cd177e6"} 12:10:08 INFO - Running post-run listener: copy_logs_to_upload_dir 12:10:08 INFO - Copying logs to upload dir... 12:10:08 INFO - mkdir: /builds/slave/test/build/upload/logs 12:10:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.372289 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2016-04-13 12:10:08.758255) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 12:10:08.762263) ========= 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=5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e2040e4dbbdc4e8fc43cec79731dee0e61b798719744398d06fb2a888d3a55557cf40158c265fd5d005fe0f2820307c3fd54c24ae0fece816463c8f8545bf0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e076d9d2a1e2e943ae77c6ef493d999ce15324b602c4439739407823d76b2e7e0d62d085ff25c378cb61e2cf0c1e1957d0574131bfadfab93b893cb6cd177e6"} build_url:https://queue.taskcluster.net/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/GliNxUYTRey5aQ0Uk0anBA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e2040e4dbbdc4e8fc43cec79731dee0e61b798719744398d06fb2a888d3a55557cf40158c265fd5d005fe0f2820307c3fd54c24ae0fece816463c8f8545bf0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e076d9d2a1e2e943ae77c6ef493d999ce15324b602c4439739407823d76b2e7e0d62d085ff25c378cb61e2cf0c1e1957d0574131bfadfab93b893cb6cd177e6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 12:10:08.789631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 12:10:08.790003) ========= 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=5bd038846534b2fdfa68eeae000001e2-1460573263.67506-1030023989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 12:10:08.873291) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 12:10:08.873697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 12:10:08.874191) ========= ========= Total master_lag: 0.30 =========