builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1460093121.23 results: success (0) buildid: 20160407220538 builduid: c50cd10d59474e33af57162747c82975 revision: 34293bb847d1e28198d596a87ea4baf96bfb0286 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.231622) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.232183) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.232553) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006308 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.259999) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.260461) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.279221) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.279543) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.329730) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.330032) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.330459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.330790) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-07 22:25:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.4M=0s 2016-04-07 22:25:21 (34.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142542 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.486596) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.486961) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014959 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.539538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:21.539918) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 34293bb847d1e28198d596a87ea4baf96bfb0286 --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 34293bb847d1e28198d596a87ea4baf96bfb0286 --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=a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-07 22:25:21,803 truncating revision to first 12 chars 2016-04-07 22:25:21,803 Setting DEBUG logging. 2016-04-07 22:25:21,803 attempt 1/10 2016-04-07 22:25:21,803 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/34293bb847d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 22:25:22,065 unpacking tar archive at: fx-team-34293bb847d1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545948 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:22.099379) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:22.099814) ========= echo 34293bb847d1e28198d596a87ea4baf96bfb0286 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'34293bb847d1e28198d596a87ea4baf96bfb0286'] 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=a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 34293bb847d1e28198d596a87ea4baf96bfb0286 program finished with exit code 0 elapsedTime=0.004843 script_repo_revision: '34293bb847d1e28198d596a87ea4baf96bfb0286' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:22.151887) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:22.152265) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 22:25:22.226933) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-07 22:25:22.227285) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:25:22 INFO - MultiFileLogger online at 20160407 22:25:22 in /builds/slave/test 22:25:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:25:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:25:22 INFO - {'append_to_log': False, 22:25:22 INFO - 'base_work_dir': '/builds/slave/test', 22:25:22 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:25:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:25:22 INFO - 'branch': 'Fx-Team-Non-PGO', 22:25:22 INFO - 'buildbot_json_path': 'buildprops.json', 22:25:22 INFO - 'config_files': ('talos/linux_config.py',), 22:25:22 INFO - 'default_actions': ('clobber', 22:25:22 INFO - 'read-buildbot-config', 22:25:22 INFO - 'download-and-extract', 22:25:22 INFO - 'populate-webroot', 22:25:22 INFO - 'create-virtualenv', 22:25:22 INFO - 'install', 22:25:22 INFO - 'run-tests'), 22:25:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:25:22 INFO - 'download_minidump_stackwalk': True, 22:25:22 INFO - 'download_symbols': 'ondemand', 22:25:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:25:22 INFO - 'tooltool.py': '/tools/tooltool.py', 22:25:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:25:22 INFO - '/tools/misc-python/virtualenv.py')}, 22:25:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:25:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:25:22 INFO - 'installer_path': 'installer.exe', 22:25:22 INFO - 'log_level': 'info', 22:25:22 INFO - 'log_name': 'talos', 22:25:22 INFO - 'log_to_console': True, 22:25:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:25:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:25:22 INFO - 'opt_config_files': (), 22:25:22 INFO - 'pip_index': False, 22:25:22 INFO - 'sps_profile': False, 22:25:22 INFO - 'sps_profile_interval': 0, 22:25:22 INFO - 'suite': 'dromaeojs-e10s', 22:25:22 INFO - 'system_bits': '32', 22:25:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:25:22 INFO - 'title': 'talos-linux64-ix-064', 22:25:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:25:22 INFO - 'use_talos_json': True, 22:25:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:25:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:25:22 INFO - 'work_dir': 'build'} 22:25:22 INFO - ##### 22:25:22 INFO - ##### Running clobber step. 22:25:22 INFO - ##### 22:25:22 INFO - Running pre-action listener: _resource_record_pre_action 22:25:22 INFO - Running main action method: clobber 22:25:22 INFO - rmtree: /builds/slave/test/build 22:25:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:25:23 INFO - Running post-action listener: _resource_record_post_action 22:25:23 INFO - ##### 22:25:23 INFO - ##### Running read-buildbot-config step. 22:25:23 INFO - ##### 22:25:23 INFO - Running pre-action listener: _resource_record_pre_action 22:25:23 INFO - Running main action method: read_buildbot_config 22:25:23 INFO - Using buildbot properties: 22:25:23 INFO - { 22:25:23 INFO - "project": "", 22:25:23 INFO - "product": "firefox", 22:25:23 INFO - "script_repo_revision": "production", 22:25:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:25:23 INFO - "repository": "", 22:25:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:25:23 INFO - "buildid": "20160407220538", 22:25:23 INFO - "pgo_build": "False", 22:25:23 INFO - "basedir": "/builds/slave/test", 22:25:23 INFO - "buildnumber": 1116, 22:25:23 INFO - "slavename": "talos-linux64-ix-064", 22:25:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:25:23 INFO - "platform": "ubuntu64_hw", 22:25:23 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:25:23 INFO - "branch": "fx-team", 22:25:23 INFO - "repo_path": "integration/fx-team", 22:25:23 INFO - "revision": "34293bb847d1e28198d596a87ea4baf96bfb0286", 22:25:23 INFO - "stage_platform": "linux64", 22:25:23 INFO - "builduid": "c50cd10d59474e33af57162747c82975", 22:25:23 INFO - "slavebuilddir": "test" 22:25:23 INFO - } 22:25:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:25:23 INFO - Running post-action listener: _resource_record_post_action 22:25:23 INFO - ##### 22:25:23 INFO - ##### Running download-and-extract step. 22:25:23 INFO - ##### 22:25:23 INFO - Running pre-action listener: _resource_record_pre_action 22:25:23 INFO - Running main action method: download_and_extract 22:25:23 INFO - mkdir: /builds/slave/test/build/tests 22:25:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:23 INFO - https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:25:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:25:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:25:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/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 22:25:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/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 22:25:29 INFO - Downloaded 1361 bytes. 22:25:29 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:25:29 INFO - Using the following test package requirements: 22:25:29 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:25:29 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:25:29 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:25:29 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:29 INFO - u'jsshell-linux-x86_64.zip'], 22:25:29 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:25:29 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:25:29 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:25:29 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:25:29 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:25:29 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:25:29 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:25:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:25:29 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')]} 22:25:29 INFO - https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:25:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:25:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:25:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/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 22:25:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/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 22:25:32 INFO - Downloaded 22186728 bytes. 22:25:32 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'] 22:25:32 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 22:25:34 INFO - Return code: 0 22:25:34 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 22:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:34 INFO - https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:25:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:25:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:25:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/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 22:25:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/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 22:25:35 INFO - Downloaded 22186728 bytes. 22:25:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:25:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:25:36 INFO - Return code: 0 22:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:36 INFO - https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:25:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:25:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:25:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/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 22:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/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 22:25:37 INFO - Downloaded 10847693 bytes. 22:25:37 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'] 22:25:37 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 22:25:38 INFO - Return code: 0 22:25:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:38 INFO - https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:25:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:25:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:25:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/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 22:25:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OBipYVyDR6u3kKmj7QpCxQ/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 22:25:39 INFO - Downloaded 54048357 bytes. 22:25:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:25:39 INFO - mkdir: /builds/slave/test/properties 22:25:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:25:39 INFO - Writing to file /builds/slave/test/properties/build_url 22:25:39 INFO - Contents: 22:25:39 INFO - build_url:https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:25:40 INFO - Running post-action listener: _resource_record_post_action 22:25:40 INFO - Running post-action listener: set_extra_try_arguments 22:25:40 INFO - ##### 22:25:40 INFO - ##### Running populate-webroot step. 22:25:40 INFO - ##### 22:25:40 INFO - Running pre-action listener: _resource_record_pre_action 22:25:40 INFO - Running main action method: populate_webroot 22:25:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:25:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:25:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:25:40 INFO - '--tppagecycles', 22:25:40 INFO - '7'], 22:25:40 INFO - 'tests': ['tsvgm']}}, 22:25:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:25:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:25:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:25:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:25:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:25:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:25:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:40 INFO - 'talos_options': ['--disable-e10s'], 22:25:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:25:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:25:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:40 INFO - 'talos_options': ['--disable-e10s'], 22:25:40 INFO - 'tests': ['damp', 'tps']}, 22:25:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:40 INFO - 'tests': ['damp', 'tps']}, 22:25:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:25:40 INFO - 'tests': ['dromaeo_dom']}, 22:25:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:25:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:25:40 INFO - 'tests': ['a11yr', 22:25:40 INFO - 'ts_paint', 22:25:40 INFO - 'tpaint', 22:25:40 INFO - 'sessionrestore', 22:25:40 INFO - 'sessionrestore_no_auto_restore', 22:25:40 INFO - 'tabpaint']}, 22:25:40 INFO - 'other-e10s': {'tests': ['a11yr', 22:25:40 INFO - 'ts_paint', 22:25:40 INFO - 'tpaint', 22:25:40 INFO - 'sessionrestore', 22:25:40 INFO - 'sessionrestore_no_auto_restore', 22:25:40 INFO - 'tabpaint']}, 22:25:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:25:40 INFO - 'ts_paint', 22:25:40 INFO - 'tpaint', 22:25:40 INFO - 'sessionrestore', 22:25:40 INFO - 'sessionrestore_no_auto_restore', 22:25:40 INFO - 'tabpaint']}, 22:25:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:25:40 INFO - 'ts_paint', 22:25:40 INFO - 'tpaint', 22:25:40 INFO - 'sessionrestore', 22:25:40 INFO - 'sessionrestore_no_auto_restore', 22:25:40 INFO - 'tabpaint']}, 22:25:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:25:40 INFO - 'tests': ['a11yr', 22:25:40 INFO - 'ts_paint', 22:25:40 INFO - 'tpaint', 22:25:40 INFO - 'sessionrestore', 22:25:40 INFO - 'sessionrestore_no_auto_restore', 22:25:40 INFO - 'tabpaint']}, 22:25:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:25:40 INFO - 'tests': ['a11yr', 22:25:40 INFO - 'ts_paint', 22:25:40 INFO - 'tpaint', 22:25:40 INFO - 'sessionrestore', 22:25:40 INFO - 'sessionrestore_no_auto_restore', 22:25:40 INFO - 'tabpaint']}, 22:25:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:25:40 INFO - 'tests': ['tsvgx', 22:25:40 INFO - 'tsvgr_opacity', 22:25:40 INFO - 'tart', 22:25:40 INFO - 'tscrollx', 22:25:40 INFO - 'cart']}, 22:25:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:25:40 INFO - 'tsvgr_opacity', 22:25:40 INFO - 'tart', 22:25:40 INFO - 'tscrollx', 22:25:40 INFO - 'cart']}, 22:25:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:40 INFO - 'talos_options': ['--disable-e10s'], 22:25:40 INFO - 'tests': ['tp5o']}, 22:25:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:40 INFO - 'tests': ['tp5o']}, 22:25:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:40 INFO - 'talos_options': ['--disable-e10s', 22:25:40 INFO - '--xperf_path', 22:25:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:25:40 INFO - 'tests': ['tp5n']}, 22:25:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:25:40 INFO - 'talos_options': ['--xperf_path', 22:25:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:25:40 INFO - 'tests': ['tp5n']}}, 22:25:40 INFO - 'talos.zip': {'path': '', 22:25:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:25:40 INFO - Running post-action listener: _resource_record_post_action 22:25:40 INFO - ##### 22:25:40 INFO - ##### Running create-virtualenv step. 22:25:40 INFO - ##### 22:25:40 INFO - Running pre-action listener: _resource_record_pre_action 22:25:40 INFO - Running main action method: create_virtualenv 22:25:40 INFO - Creating virtualenv /builds/slave/test/build/venv 22:25:40 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 22:25:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:25:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:25:40 INFO - Using real prefix '/usr' 22:25:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:25:41 INFO - Installing distribute.............................................................................................................................................................................................done. 22:25:43 INFO - Installing pip.................done. 22:25:43 INFO - Return code: 0 22:25:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:25:43 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')]} 22:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:43 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')]} 22:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:43 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 0x7f816872cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c410>, '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 0x1a2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', '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 22:25:43 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 22:25:43 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 22:25:43 INFO - Using env: {'DISPLAY': ':0', 22:25:43 INFO - 'HOME': '/home/cltbld', 22:25:43 INFO - 'LANG': 'en_US.UTF-8', 22:25:43 INFO - 'LANGUAGE': 'en_US:en', 22:25:43 INFO - 'LOGNAME': 'cltbld', 22:25:43 INFO - 'MAIL': '/var/mail/cltbld', 22:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:43 INFO - 'MOZ_NO_REMOTE': '1', 22:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:43 INFO - 'NO_EM_RESTART': '1', 22:25:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:43 INFO - 'PWD': '/builds/slave/test', 22:25:43 INFO - 'SHELL': '/bin/bash', 22:25:43 INFO - 'SHLVL': '1', 22:25:43 INFO - 'TERM': 'linux', 22:25:43 INFO - 'TMOUT': '86400', 22:25:43 INFO - 'USER': 'cltbld', 22:25:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', 22:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:43 INFO - '_': '/tools/buildbot/bin/python'} 22:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:43 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 22:25:43 INFO - Cleaning up... 22:25:43 INFO - Return code: 0 22:25:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:25:43 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')]} 22:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:43 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')]} 22:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:43 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 0x7f816872cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c410>, '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 0x1a2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', '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 22:25:43 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 22:25:43 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 22:25:43 INFO - Using env: {'DISPLAY': ':0', 22:25:43 INFO - 'HOME': '/home/cltbld', 22:25:43 INFO - 'LANG': 'en_US.UTF-8', 22:25:43 INFO - 'LANGUAGE': 'en_US:en', 22:25:43 INFO - 'LOGNAME': 'cltbld', 22:25:43 INFO - 'MAIL': '/var/mail/cltbld', 22:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:43 INFO - 'MOZ_NO_REMOTE': '1', 22:25:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:43 INFO - 'NO_EM_RESTART': '1', 22:25:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:43 INFO - 'PWD': '/builds/slave/test', 22:25:43 INFO - 'SHELL': '/bin/bash', 22:25:43 INFO - 'SHLVL': '1', 22:25:43 INFO - 'TERM': 'linux', 22:25:43 INFO - 'TMOUT': '86400', 22:25:43 INFO - 'USER': 'cltbld', 22:25:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', 22:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:43 INFO - '_': '/tools/buildbot/bin/python'} 22:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:43 INFO - Downloading/unpacking psutil>=0.7.1 22:25:43 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 22:25:43 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 22:25:43 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 22:25:43 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 22:25:43 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 22:25:43 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 22:25:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:25:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:25:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:25:45 INFO - Installing collected packages: psutil 22:25:45 INFO - Running setup.py install for psutil 22:25:45 INFO - building 'psutil._psutil_linux' extension 22:25:45 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 22:25:45 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 22:25:45 INFO - building 'psutil._psutil_posix' extension 22:25:45 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 22:25:45 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 22:25:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:25:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:25:46 INFO - Successfully installed psutil 22:25:46 INFO - Cleaning up... 22:25:46 INFO - Return code: 0 22:25:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f816872cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c410>, '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 0x1a2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', '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 22:25:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:25:46 INFO - Using env: {'DISPLAY': ':0', 22:25:46 INFO - 'HOME': '/home/cltbld', 22:25:46 INFO - 'LANG': 'en_US.UTF-8', 22:25:46 INFO - 'LANGUAGE': 'en_US:en', 22:25:46 INFO - 'LOGNAME': 'cltbld', 22:25:46 INFO - 'MAIL': '/var/mail/cltbld', 22:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:46 INFO - 'MOZ_NO_REMOTE': '1', 22:25:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:46 INFO - 'NO_EM_RESTART': '1', 22:25:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:46 INFO - 'PWD': '/builds/slave/test', 22:25:46 INFO - 'SHELL': '/bin/bash', 22:25:46 INFO - 'SHLVL': '1', 22:25:46 INFO - 'TERM': 'linux', 22:25:46 INFO - 'TMOUT': '86400', 22:25:46 INFO - 'USER': 'cltbld', 22:25:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', 22:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:46 INFO - '_': '/tools/buildbot/bin/python'} 22:25:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:25:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:25:48 INFO - Installing collected packages: mozsystemmonitor 22:25:48 INFO - Running setup.py install for mozsystemmonitor 22:25:48 INFO - Successfully installed mozsystemmonitor 22:25:48 INFO - Cleaning up... 22:25:48 INFO - Return code: 0 22:25:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:25: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')]} 22:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25: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')]} 22:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25: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', '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 0x7f816872cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c410>, '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 0x1a2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', '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 22:25: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:25: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 blobuploader==1.2.4 22:25:48 INFO - Using env: {'DISPLAY': ':0', 22:25:48 INFO - 'HOME': '/home/cltbld', 22:25:48 INFO - 'LANG': 'en_US.UTF-8', 22:25:48 INFO - 'LANGUAGE': 'en_US:en', 22:25:48 INFO - 'LOGNAME': 'cltbld', 22:25:48 INFO - 'MAIL': '/var/mail/cltbld', 22:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:48 INFO - 'MOZ_NO_REMOTE': '1', 22:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:48 INFO - 'NO_EM_RESTART': '1', 22:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:48 INFO - 'PWD': '/builds/slave/test', 22:25:48 INFO - 'SHELL': '/bin/bash', 22:25:48 INFO - 'SHLVL': '1', 22:25:48 INFO - 'TERM': 'linux', 22:25:48 INFO - 'TMOUT': '86400', 22:25:48 INFO - 'USER': 'cltbld', 22:25:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', 22:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:48 INFO - '_': '/tools/buildbot/bin/python'} 22:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:48 INFO - Downloading/unpacking blobuploader==1.2.4 22:25: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 22:25: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 22:25: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 22:25: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 22:25: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 22:25: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 22:25:50 INFO - Downloading blobuploader-1.2.4.tar.gz 22:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:25:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:25: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 22:25: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 22:25: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 22:25: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 22:25: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 22:25: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 22:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:25:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:25: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 22:25: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 22:25: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 22:25: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 22:25: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 22:25: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 22:25:51 INFO - Downloading docopt-0.6.1.tar.gz 22:25:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:25:51 INFO - Installing collected packages: blobuploader, requests, docopt 22:25:51 INFO - Running setup.py install for blobuploader 22:25:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:25:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:25:51 INFO - Running setup.py install for requests 22:25:51 INFO - Running setup.py install for docopt 22:25:51 INFO - Successfully installed blobuploader requests docopt 22:25:51 INFO - Cleaning up... 22:25:51 INFO - Return code: 0 22:25:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:51 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 0x7f816872cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c410>, '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 0x1a2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', '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 22:25:51 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 22:25:51 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 22:25:51 INFO - Using env: {'DISPLAY': ':0', 22:25:51 INFO - 'HOME': '/home/cltbld', 22:25:51 INFO - 'LANG': 'en_US.UTF-8', 22:25:51 INFO - 'LANGUAGE': 'en_US:en', 22:25:51 INFO - 'LOGNAME': 'cltbld', 22:25:51 INFO - 'MAIL': '/var/mail/cltbld', 22:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:51 INFO - 'MOZ_NO_REMOTE': '1', 22:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:51 INFO - 'NO_EM_RESTART': '1', 22:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:51 INFO - 'PWD': '/builds/slave/test', 22:25:51 INFO - 'SHELL': '/bin/bash', 22:25:51 INFO - 'SHLVL': '1', 22:25:51 INFO - 'TERM': 'linux', 22:25:51 INFO - 'TMOUT': '86400', 22:25:51 INFO - 'USER': 'cltbld', 22:25:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', 22:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:51 INFO - '_': '/tools/buildbot/bin/python'} 22:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:25:52 INFO - Running setup.py (path:/tmp/pip-xC8mQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:25:52 INFO - Running setup.py (path:/tmp/pip-uhzpnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:25:52 INFO - Running setup.py (path:/tmp/pip-XGAbog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:25:52 INFO - Running setup.py (path:/tmp/pip-EokveC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:25:52 INFO - Running setup.py (path:/tmp/pip-oXL5Fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:25:52 INFO - Running setup.py (path:/tmp/pip-wTxfMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:25:52 INFO - Running setup.py (path:/tmp/pip-18XPYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:25:52 INFO - Running setup.py (path:/tmp/pip-D7x5Wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:25:52 INFO - Running setup.py (path:/tmp/pip-6_rLbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:25:52 INFO - Running setup.py (path:/tmp/pip-l_yYzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:25:52 INFO - Running setup.py (path:/tmp/pip-cyKczp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:25:52 INFO - Running setup.py (path:/tmp/pip-MzF4U8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:25:52 INFO - Running setup.py (path:/tmp/pip-PAj8pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:25:53 INFO - Running setup.py (path:/tmp/pip-gOtwA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:25:53 INFO - Running setup.py (path:/tmp/pip-OhGo_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:25:53 INFO - Running setup.py (path:/tmp/pip-3PSoIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:25:53 INFO - Running setup.py (path:/tmp/pip-gqQ2wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:25:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:25:53 INFO - Running setup.py install for manifestparser 22:25:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:25:53 INFO - Running setup.py install for mozcrash 22:25:53 INFO - Running setup.py install for mozdebug 22:25:53 INFO - Running setup.py install for mozdevice 22:25:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:25:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:25:53 INFO - Running setup.py install for mozfile 22:25:53 INFO - Running setup.py install for mozhttpd 22:25:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:25:53 INFO - Running setup.py install for mozinfo 22:25:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:25:54 INFO - Running setup.py install for mozInstall 22:25:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:25:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:25:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:25:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:25:54 INFO - Running setup.py install for mozleak 22:25:54 INFO - Running setup.py install for mozlog 22:25:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:25:54 INFO - Running setup.py install for moznetwork 22:25:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:25:54 INFO - Running setup.py install for mozprocess 22:25:54 INFO - Running setup.py install for mozprofile 22:25:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:25:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:25:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:25:54 INFO - Running setup.py install for mozrunner 22:25:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:25:54 INFO - Running setup.py install for mozscreenshot 22:25:54 INFO - Running setup.py install for moztest 22:25:54 INFO - Running setup.py install for mozversion 22:25:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:25:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:25:55 INFO - Cleaning up... 22:25:55 INFO - Return code: 0 22:25:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:55 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 0x7f816872cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c410>, '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 0x1a2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', '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 22:25:55 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 22:25:55 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 22:25:55 INFO - Using env: {'DISPLAY': ':0', 22:25:55 INFO - 'HOME': '/home/cltbld', 22:25:55 INFO - 'LANG': 'en_US.UTF-8', 22:25:55 INFO - 'LANGUAGE': 'en_US:en', 22:25:55 INFO - 'LOGNAME': 'cltbld', 22:25:55 INFO - 'MAIL': '/var/mail/cltbld', 22:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:55 INFO - 'MOZ_NO_REMOTE': '1', 22:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:55 INFO - 'NO_EM_RESTART': '1', 22:25:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:55 INFO - 'PWD': '/builds/slave/test', 22:25:55 INFO - 'SHELL': '/bin/bash', 22:25:55 INFO - 'SHLVL': '1', 22:25:55 INFO - 'TERM': 'linux', 22:25:55 INFO - 'TMOUT': '86400', 22:25:55 INFO - 'USER': 'cltbld', 22:25:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', 22:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:55 INFO - '_': '/tools/buildbot/bin/python'} 22:25:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:25:55 INFO - Running setup.py (path:/tmp/pip-JaGp1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:25:55 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)) 22:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:25:55 INFO - Running setup.py (path:/tmp/pip-RUFvG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:25:55 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)) 22:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:25:55 INFO - Running setup.py (path:/tmp/pip-04nE5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:25:55 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)) 22:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:25:55 INFO - Running setup.py (path:/tmp/pip-pJBomi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:25:55 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)) 22:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:25:55 INFO - Running setup.py (path:/tmp/pip-yWFtaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:25:55 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)) 22:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:25:55 INFO - Running setup.py (path:/tmp/pip-dktfv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:25:55 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)) 22:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:25:55 INFO - Running setup.py (path:/tmp/pip-Nd1FEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:25:55 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)) 22:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:25:55 INFO - Running setup.py (path:/tmp/pip-uZbemj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:25:55 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)) 22:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:25:55 INFO - Running setup.py (path:/tmp/pip-p6wa7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:25:55 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)) 22:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:25:55 INFO - Running setup.py (path:/tmp/pip-Vm6M0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:25:56 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)) 22:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:25:56 INFO - Running setup.py (path:/tmp/pip-2KD_Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:25:56 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)) 22:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:25:56 INFO - Running setup.py (path:/tmp/pip-LlNtSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:25:56 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)) 22:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:25:56 INFO - Running setup.py (path:/tmp/pip-07hrOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:25:56 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)) 22:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:25:56 INFO - Running setup.py (path:/tmp/pip-5WgMWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:25:56 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)) 22:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:25:56 INFO - Running setup.py (path:/tmp/pip-aPELpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:25:56 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)) 22:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:25:56 INFO - Running setup.py (path:/tmp/pip-zCh5AX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:25:56 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)) 22:25:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:25:56 INFO - Running setup.py (path:/tmp/pip-waWsVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:25:56 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)) 22:25:56 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)) 22:25:56 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)) 22:25:56 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)) 22:25:56 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)) 22:25:56 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)) 22:25:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:25:56 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 22:25:56 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 22:25:56 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 22:25:56 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 22:25:56 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 22:25:56 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 22:25:58 INFO - Downloading blessings-1.6.tar.gz 22:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:25:58 INFO - Installing collected packages: blessings 22:25:58 INFO - Running setup.py install for blessings 22:25:58 INFO - Successfully installed blessings 22:25:58 INFO - Cleaning up... 22:25:58 INFO - Return code: 0 22:25:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:25:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:25:58 INFO - Reading from file tmpfile_stdout 22:25:58 INFO - Current package versions: 22:25:58 INFO - argparse == 1.2.1 22:25:58 INFO - blessings == 1.6 22:25:58 INFO - blobuploader == 1.2.4 22:25:58 INFO - docopt == 0.6.1 22:25:58 INFO - manifestparser == 1.1 22:25:58 INFO - mozInstall == 1.12 22:25:58 INFO - mozcrash == 0.17 22:25:58 INFO - mozdebug == 0.1 22:25:58 INFO - mozdevice == 0.48 22:25:58 INFO - mozfile == 1.2 22:25:58 INFO - mozhttpd == 0.7 22:25:58 INFO - mozinfo == 0.9 22:25:58 INFO - mozleak == 0.1 22:25:58 INFO - mozlog == 3.1 22:25:58 INFO - moznetwork == 0.27 22:25:58 INFO - mozprocess == 0.22 22:25:58 INFO - mozprofile == 0.28 22:25:58 INFO - mozrunner == 6.11 22:25:58 INFO - mozscreenshot == 0.1 22:25:58 INFO - mozsystemmonitor == 0.0 22:25:58 INFO - moztest == 0.7 22:25:58 INFO - mozversion == 1.4 22:25:58 INFO - psutil == 3.1.1 22:25:58 INFO - requests == 1.2.3 22:25:58 INFO - wsgiref == 0.1.2 22:25:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:58 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 0x7f816872cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c410>, '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 0x1a2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', '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 22:25:58 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 22:25:58 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 22:25:58 INFO - Using env: {'DISPLAY': ':0', 22:25:58 INFO - 'HOME': '/home/cltbld', 22:25:58 INFO - 'LANG': 'en_US.UTF-8', 22:25:58 INFO - 'LANGUAGE': 'en_US:en', 22:25:58 INFO - 'LOGNAME': 'cltbld', 22:25:58 INFO - 'MAIL': '/var/mail/cltbld', 22:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:58 INFO - 'MOZ_NO_REMOTE': '1', 22:25:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:58 INFO - 'NO_EM_RESTART': '1', 22:25:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:58 INFO - 'PWD': '/builds/slave/test', 22:25:58 INFO - 'SHELL': '/bin/bash', 22:25:58 INFO - 'SHLVL': '1', 22:25:58 INFO - 'TERM': 'linux', 22:25:58 INFO - 'TMOUT': '86400', 22:25:58 INFO - 'USER': 'cltbld', 22:25:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', 22:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:58 INFO - '_': '/tools/buildbot/bin/python'} 22:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:59 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)) 22:25:59 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)) 22:25:59 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)) 22:25:59 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)) 22:25:59 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)) 22:25:59 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)) 22:25:59 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)) 22:25:59 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)) 22:25:59 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)) 22:25:59 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)) 22:25:59 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)) 22:25:59 INFO - Cleaning up... 22:25:59 INFO - Return code: 0 22:25:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:25:59 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 0x7f816872cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c410>, '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 0x1a2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', '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 22:25:59 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 22:25:59 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 22:25:59 INFO - Using env: {'DISPLAY': ':0', 22:25:59 INFO - 'HOME': '/home/cltbld', 22:25:59 INFO - 'LANG': 'en_US.UTF-8', 22:25:59 INFO - 'LANGUAGE': 'en_US:en', 22:25:59 INFO - 'LOGNAME': 'cltbld', 22:25:59 INFO - 'MAIL': '/var/mail/cltbld', 22:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:59 INFO - 'MOZ_NO_REMOTE': '1', 22:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:59 INFO - 'NO_EM_RESTART': '1', 22:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:59 INFO - 'PWD': '/builds/slave/test', 22:25:59 INFO - 'SHELL': '/bin/bash', 22:25:59 INFO - 'SHLVL': '1', 22:25:59 INFO - 'TERM': 'linux', 22:25:59 INFO - 'TMOUT': '86400', 22:25:59 INFO - 'USER': 'cltbld', 22:25:59 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', 22:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:59 INFO - '_': '/tools/buildbot/bin/python'} 22:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:25:59 INFO - Downloading/unpacking jsonschema 22:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:25:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:26:01 INFO - Downloading/unpacking functools32 (from jsonschema) 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26:01 INFO - Downloading functools32-3.2.3-2.tar.gz 22:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:26:01 INFO - warning: no files found matching '*.txt' 22:26:01 INFO - no previously-included directories found matching 'build' 22:26:01 INFO - no previously-included directories found matching 'dist' 22:26:01 INFO - no previously-included directories found matching '.git*' 22:26:01 INFO - Installing collected packages: jsonschema, functools32 22:26:01 INFO - Running setup.py install for functools32 22:26:01 INFO - warning: no files found matching '*.txt' 22:26:01 INFO - no previously-included directories found matching 'build' 22:26:01 INFO - no previously-included directories found matching 'dist' 22:26:01 INFO - no previously-included directories found matching '.git*' 22:26:01 INFO - Successfully installed jsonschema functools32 22:26:01 INFO - Cleaning up... 22:26:01 INFO - Return code: 0 22:26:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:26: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')]} 22:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26: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')]} 22:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:26: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f816872cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2c410>, '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 0x1a2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d7a0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', '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 22:26: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', 'flake8'] in /builds/slave/test/build 22:26: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 flake8 22:26:01 INFO - Using env: {'DISPLAY': ':0', 22:26:01 INFO - 'HOME': '/home/cltbld', 22:26:01 INFO - 'LANG': 'en_US.UTF-8', 22:26:01 INFO - 'LANGUAGE': 'en_US:en', 22:26:01 INFO - 'LOGNAME': 'cltbld', 22:26:01 INFO - 'MAIL': '/var/mail/cltbld', 22:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:01 INFO - 'MOZ_NO_REMOTE': '1', 22:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:01 INFO - 'NO_EM_RESTART': '1', 22:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:01 INFO - 'PWD': '/builds/slave/test', 22:26:01 INFO - 'SHELL': '/bin/bash', 22:26:01 INFO - 'SHLVL': '1', 22:26:01 INFO - 'TERM': 'linux', 22:26:01 INFO - 'TMOUT': '86400', 22:26:01 INFO - 'USER': 'cltbld', 22:26:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', 22:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:01 INFO - '_': '/tools/buildbot/bin/python'} 22:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:26:01 INFO - Downloading/unpacking flake8 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:26:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26: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 22:26:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:26:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:26:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:26:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:26:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:26:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:26:04 INFO - no previously-included directories found matching 'docs/_build' 22:26:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:26:04 INFO - Running setup.py install for pep8 22:26:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:26:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:26:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:26:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:26:04 INFO - no previously-included directories found matching 'docs/_build' 22:26:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:26:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:26:04 INFO - Cleaning up... 22:26:04 INFO - Return code: 0 22:26:04 INFO - Running post-action listener: _resource_record_post_action 22:26:04 INFO - Running post-action listener: _start_resource_monitoring 22:26:04 INFO - Starting resource monitoring. 22:26:04 INFO - ##### 22:26:04 INFO - ##### Running install step. 22:26:04 INFO - ##### 22:26:04 INFO - Running pre-action listener: _resource_record_pre_action 22:26:04 INFO - Running main action method: install 22:26:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:26:05 INFO - Reading from file tmpfile_stdout 22:26:05 INFO - Detecting whether we're running mozinstall >=1.0... 22:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:26:05 INFO - Reading from file tmpfile_stdout 22:26:05 INFO - Output received: 22:26:05 INFO - Usage: mozinstall [options] installer 22:26:05 INFO - Options: 22:26:05 INFO - -h, --help show this help message and exit 22:26:05 INFO - -d DEST, --destination=DEST 22:26:05 INFO - Directory to install application into. [default: 22:26:05 INFO - "/builds/slave/test"] 22:26:05 INFO - --app=APP Application being installed. [default: firefox] 22:26:05 INFO - mkdir: /builds/slave/test/build/application 22:26:05 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'] 22:26:05 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 22:26:20 INFO - Reading from file tmpfile_stdout 22:26:20 INFO - Output received: 22:26:20 INFO - /builds/slave/test/build/application/firefox/firefox 22:26:20 INFO - Running post-action listener: _resource_record_post_action 22:26:20 INFO - ##### 22:26:20 INFO - ##### Running run-tests step. 22:26:20 INFO - ##### 22:26:20 INFO - Running pre-action listener: _resource_record_pre_action 22:26:20 INFO - Running main action method: run_tests 22:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:26:20 INFO - Python 2.7.3 22:26:20 INFO - Return code: 0 22:26:20 INFO - grabbing minidump binary from tooltool 22:26:20 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')]} 22:26:20 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 0x1a2c410>, '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 0x1a2d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:26:20 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 22:26:20 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 22:26:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:26:20 INFO - Return code: 0 22:26:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:26:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:26:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:26:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:26:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:26:21 INFO - Return code: 0 22:26:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:26:21 INFO - Using env: {'DISPLAY': ':0', 22:26:21 INFO - 'HOME': '/home/cltbld', 22:26:21 INFO - 'LANG': 'en_US.UTF-8', 22:26:21 INFO - 'LANGUAGE': 'en_US:en', 22:26:21 INFO - 'LOGNAME': 'cltbld', 22:26:21 INFO - 'MAIL': '/var/mail/cltbld', 22:26:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:26:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:26:21 INFO - 'MOZ_NO_REMOTE': '1', 22:26:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:26:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:26:21 INFO - 'NO_EM_RESTART': '1', 22:26:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:26:21 INFO - 'PWD': '/builds/slave/test', 22:26:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:26:21 INFO - 'SHELL': '/bin/bash', 22:26:21 INFO - 'SHLVL': '1', 22:26:21 INFO - 'TERM': 'linux', 22:26:21 INFO - 'TMOUT': '86400', 22:26:21 INFO - 'USER': 'cltbld', 22:26:21 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377', 22:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:26:21 INFO - '_': '/tools/buildbot/bin/python'} 22:26:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:26:21 INFO - mozversion application_buildid: 20160407220538 22:26:21 INFO - mozversion application_changeset: 34293bb847d1e28198d596a87ea4baf96bfb0286 22:26:21 INFO - mozversion application_display_name: Nightly 22:26:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:26:21 INFO - mozversion application_name: Firefox 22:26:21 INFO - mozversion application_remotingname: firefox 22:26:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:26:21 INFO - mozversion application_vendor: Mozilla 22:26:21 INFO - mozversion application_version: 48.0a1 22:26:21 INFO - mozversion platform_buildid: 20160407220538 22:26:21 INFO - mozversion platform_changeset: 34293bb847d1e28198d596a87ea4baf96bfb0286 22:26:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:26:21 INFO - mozversion platform_version: 48.0a1 22:26:21 INFO - using testdate: 1460093181 22:26:21 INFO - actual date: 1460093181 22:26:21 INFO - starting webserver on 'localhost:56793' 22:26:21 INFO - SUITE-START | Running 2 tests 22:26:21 INFO - TEST-START | dromaeo_css 22:26:21 INFO - operating with platform_type : linux_ 22:26:21 INFO - Initialising browser for dromaeo_css test... 22:26:22 INFO - TEST-INFO | started process 20283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphqRgUF/profile http://localhost:56793/getInfo.html) 22:26:26 INFO - PROCESS | 20283 | 22:26:26 INFO - PROCESS | 20283 | (process:20351): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:26:26 INFO - PROCESS | 20283 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 22:26:27 INFO - PROCESS | 20283 | __metrics Screen width/height:1600/1200 22:26:27 INFO - PROCESS | 20283 | colorDepth:24 22:26:27 INFO - PROCESS | 20283 | Browser inner width/height: 1024/697 22:26:27 INFO - PROCESS | 20283 | __metrics 22:26:28 ERROR - PROCESS | 20283 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 22:26:28 INFO - TEST-INFO | 20283: exit 0 22:26:28 INFO - Browser initialized. 22:26:28 INFO - Running cycle 1/1 for dromaeo_css test... 22:26:28 INFO - TEST-INFO | started process 20402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphqRgUF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:26:30 INFO - PROCESS | 20402 | 22:26:30 INFO - PROCESS | 20402 | (process:20460): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:26:40 INFO - PROCESS | 20402 | RSS: Main: 163868672 22:26:40 INFO - PROCESS | 20402 | 22:27:30 INFO - PROCESS | 20402 | 1460093250417 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] 22:29:42 INFO - PROCESS | 20402 | Cycle 1(1): loaded http://localhost:56793/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56793/tests/dromaeo/cssquery-ext.html) 22:29:43 INFO - PROCESS | 20402 | RSS: Main: 168484864 22:29:43 INFO - PROCESS | 20402 | 22:32:45 INFO - PROCESS | 20402 | Cycle 1(1): loaded http://localhost:56793/tests/dromaeo/cssquery-ext.html (next: http://localhost:56793/tests/dromaeo/cssquery-jquery.html) 22:32:46 INFO - PROCESS | 20402 | RSS: Main: 166338560 22:32:46 INFO - PROCESS | 20402 | 22:35:48 INFO - PROCESS | 20402 | Cycle 1(1): loaded http://localhost:56793/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56793/tests/dromaeo/cssquery-mootools.html) 22:35:48 INFO - PROCESS | 20402 | RSS: Main: 167108608 22:35:48 INFO - PROCESS | 20402 | 22:38:50 INFO - PROCESS | 20402 | Cycle 1(1): loaded http://localhost:56793/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56793/tests/dromaeo/cssquery-prototype.html) 22:38:51 INFO - PROCESS | 20402 | RSS: Main: 164343808 22:38:51 INFO - PROCESS | 20402 | 22:41:53 INFO - PROCESS | 20402 | Cycle 1(1): loaded http://localhost:56793/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56793/tests/dromaeo/cssquery-yui.html) 22:41:54 INFO - PROCESS | 20402 | RSS: Main: 164429824 22:41:54 INFO - PROCESS | 20402 | 22:44:56 INFO - PROCESS | 20402 | Cycle 1(1): loaded http://localhost:56793/tests/dromaeo/cssquery-yui.html (next: http://localhost:56793/tests/dromaeo/cssquery-dojo.html) 22:44:56 INFO - PROCESS | 20402 | RSS: Main: 166940672 22:44:56 INFO - PROCESS | 20402 | 22:44:56 INFO - PROCESS | 20402 | __start_tp_report 22:44:56 INFO - PROCESS | 20402 | _x_x_mozilla_page_load 22:44:56 INFO - PROCESS | 20402 | _x_x_mozilla_page_load_details 22:44:56 INFO - PROCESS | 20402 | |i|pagename|runs| 22:44:56 INFO - PROCESS | 20402 | |0;dojo.html;2643.7884969202464;2735.53495905696;2759.765419939305;2765.4745598336312;2771.127094965085;4661.930071048929;4701.459332176796;4716.198246298129;4739.4075740532435;4764.809407623699;4688.671792974493;4729.432468103823;4821.710697358161;4868.221084626461;4877.926831097528;4367.5632436756305;4420.624246938998;4447.221736196169;4522.47991480979;4591.885202869921;4435.977820110895;4447.466304043519;4474.8881277967985;4487.214737420954;4547.317902314646;4349.043210493686;4408.3607876858;4414.933775993362;4427.889302767457;4448.7108337957925;4426.889327766799;4435.246008178618;4436.511983681792;4447.666425018137;4505.752183629899;4258.977845317133;4387.9561204387865;4412.955870441318;4430.712003719748;4464.776761161961;4711.764411779397;4728.267118596623;4749.453812811502;4755.762211889391;4791.4250289965075;5150.793968241266;5151.5363617274625;5176.301199338079;5182.144946083891;5205.063088644042;5148.099082660557;5178.482151784791;5216.150407153113;5229.738513074331;5254.21186821976;4736;4743.620510359163;4754.049190161947;4757.595604373632;4795.832145874878;5186.870328241824;5203.583713303003;5207.479252074762;5218.269442278084;5259.474052594786;4764.880877978009;4979.850604481871;5011.57401620859;5039.4708555601865;5062.038212739568;4992.276119962585;5099.898002040012;5150.150225212873;5150.201718733602;5244.659097158673;5119.718415487109;5121.129408000649;5129.589632829365;5130.1535246684625;5131;4922.729249891218;5057.671251368649;5095.261187127846;5143.151380022255;5151.150060240094;4401.515833258339;4425.557444255549;4426.392490120542;4430.645548356124;4472.060867217856;3810.8475660973804;3842.9039274018373;3849.172427928009;3890.844366225376;3898.2398432305995;4400.647948164139;4450.888727781831;4503.662225333113;4536.931946020813;4547.681662283609;5145.4854514549;5171.4828517148735;5177.870553236124;5199.142141546678;5248.527632513092;4331.328644060112;4465.0623369092855;4467.508574056851;4477.485089214717;4514.932276015862;4641.744704041243;4699.812007519661;4702.3416721659;4739.786709598007;4742.217534106902;4820.108279968217;4825.9034819304115;4845.394325709286;4866.29438731389;4917.803287868517;5012.949870501394;5079.238114282887;5158.484151584811;5160.200168973815;5226.660267082628;4777.95222047789;4792;4793.281007848851;4795.328653988375;4831.541003604652;4989.60083193351;4996.800127994985;5000.974995125001;5013.273075404119;5065.620078494054;4976.8755781105765;5087.109755792648;5094.286799848099;5128.282040514257;5185.481451854785;4805.399325084364;4865;4949.430815456269;5036.219385995177;5083.212102124176;4971.105201063843;4978.8755281118265;4980.850574482772;5003.124453220599;5018.874528136826;4755.7859896305445;4923.876903077452;4924.581410580141;4931.457539670561;4932.753362331798;4933.284673722362;4935.555799978019;4967.503249675004;4978.576820970258;4987.925181122214;4897;4904.632152588499;4913.3121363008495;4925.926111108264;4964.255361695775 22:44:56 INFO - PROCESS | 20402 | |1;ext.html;552.7043031977893;586.1705686453669;593.1814096546765;608.7230310208854;634.6636282770133;35726.464103038474;36712.51231133038;36892;36910;37001.25997480049;36372;36643.81678091606;36663.450048249295;36868.81565592175;37020.81489592555;7632.885506717404;7698.730544430946;7765.572893490856;7785.260400261966;7800.7269745558915;7555.7733268001775;7561.848763024736;7607.543547387147;7643.61781910905;7666.156722760492;7615.428842836809;7636.389088872905;7667;7693.153753087156;7725.150233474314;7594.278543538355;7645.808854778619;7647.235276472364;7665.041869766279;7681.923180768176;7689.884651730228;7694.4998575092995;7736.226377362275;7782.922170778276;7790.961045194795;33911.49132763011;34262.48606270883;34263.4860477093;34293.485597716055;34380.14049648754;2907.215051935965;3047.2686555226805;3211.6467188609236;3438.8108654024018;3728.5152930119184;27763.583546246824;28082.297942551395;28151.859240703667;28447.71552284492;28639.856800715865;3467.7225821934435;3485.2506711057245;3485.9825700871334;3501.5973163086314;3531.5408996830247;231394;232015;232072.83963580243;232626;233297;51226;51304.743476283125;51551.74224128856;51562;51776.74111629418;57795;59031.34358953858;59170.11244831331;59181.70409147927;59234.70382648059;14966.251687415586;15105.924470377797;15188.316525756147;15237.3905043797;15269.160196189094;11424.543018279343;11578.073754099652;11583.884161158448;11622.70943226426;11648.88351116478;17600.295988160586;17691.292348306182;17722.46832595024;18350;18748.437546873614;6842.521023528405;7079;7120;7151.923403659968;7171.89242161368;825.3603457320504;922.9446233226028;1010.434156872154;1013.7871047080196;1094.480121942071;27521;27652;27779.444411111665;28368.71631283661;28517;1006.3207335048813;1009.1422291052546;1010.722051435861;1019.261035749076;1041.3439533094102;14856.777148342784;14927.776083358758;15162.24188790556;15341.463048793239;15372.923135384252;340948;346600;347857;349803;351446;48122.27816582684;48585.27122093172;49029.754851225516;49086.50913490819;49193.50806491961;1216.671498695365;1244.3467179730715;1253.7429826885466;1257.126297223421;1262.4571434283346;25799;27636.585451217845;27697.861510692317;27838.747256373917;28011.299717507227;42404.363934540386;43149;43227.35158972555;43299.134017318844;43308.35037474377;249729;250580;250675;251570;252191;24887.37781555403;25009.249722508353;25201.49597008013;25203.495930081663;25434.491310173322;42186.57813421949;42313.88430578521;42835.357469638606;42976;43029.35455968226;35909.28181436409;35995.82002089973;36228.81885590555;36275.27449450943;36508.81745591255;35182.29635407226;35345.823270883484;35578.28843423065;35671;35868.28263434769;31424.528632070993;34827.129321767155;35660.46509302415;35967.64032359643;36851;28287.717122828508;28926.276843079093;29011.27471813137;29029.41941161207;29165.416691666473;23191.420214494774;23726.204576917808;24855.751442485343;24941.750582494667;25018.499630006932 22:44:56 INFO - PROCESS | 20402 | |2;jquery.html;362.34234863722344;364.5479605289442;365.30409569769586;376.83230962221825;384.30904022301866;14004.229767362804;14890.851091489081;16877.746833797504;16877.746833797504;16899.57751056224;16254.674906501863;16732.16339183042;17344.566385840328;17506.299748010064;17587.12064396778;5011.624128190382;5193.714345710984;5205.089109405858;5233.86915327118;5242.842714718565;3751.3247615429214;5118.513741194581;5555.444455554432;5908.1433192187105;5940.851478713023;5862.443067908542;5879.8530036749;5881.206037184968;5885;5902.704864756745;5622.32532096149;5864.941350586482;5903.291605007405;5932.7330270137945;5933.821985340447;4424.292113261895;5149.665271757323;5168.844934651929;5171.870703232449;5175;18408.53978650531;18518.259269629198;18891.716624250646;18942.62114757697;19403.90298048515;1715.6825987192285;1732.5235560220915;1764.876458647895;1788.8300611441891;1957.3442896629647;8643.17889800468;8754.606042728028;8863.423877447945;8882.911170888337;11726.941365293203;1648.2582837722953;1668.758030085643;1714.485654303704;1718.3126749300254;1740.1125426032688;65383.619745514814;68617.31382686159;69514.65242673804;70462.2953770466;70724;9873.802523949624;9912.504374781232;9952.502374881227;10057.748556286006;10181.287309888237;14003.649908752363;14038.719225615634;14094.154350738989;14105.506307279402;14166.433342666383;7097.396721278646;7458.850822983619;7548.320651141424;7705.691772329044;7774.494657847335;7279.781606551706;7323.9267607323245;7348.63256837156;7367.447441441914;7379.6679149438405;4241.766702831374;4274.316109422478;4281.97859010703;4348.478182618106;4355.62797718724;1599.3362754457003;1697.915104244783;1712.8715346349074;1766.9734953975444;1795.89224646519;894.8165626046645;904.4347282948157;906.4334790755778;947.9146876780985;954.7088138117801;15941.521754347388;16266.268017938984;16426;16715.6656866862;16806.495805125865;878.9208971192623;883.4346018548134;921.1617428140494;922.3820040572832;970.0348153587225;9226.953865230631;9290.674826381044;9298.070192980784;9328.766780830398;9553.808923821623;384695;386455;388902;396214;402079;43235;71116.64441677759;75175.24824751791;75191;76450.61774691091;919.9586018629178;920.3879420185635;935.2611436964858;945.1399226703667;961.6682244625453;14839.851601483848;14853.554393367784;15021.324040418425;15035.849641503444;15096.423667084568;31506.527402089447;32353.676463235068;32923.8353808239;33081;33389.33221335511;44313.33529996988;45509.08981820411;45691.77154114208;45753.771231144965;45762.77118614386;7089.184743754328;7147.356737893407;7155.606441645759;7182.820429489305;7250.347468727628;9940.602375904882;10985.231033827555;11231;11285.097192224766;11404.657860264206;9731.56207970629;9854.950725246328;9920.950395247977;9923.354981926152;10448.216383771096;10026.849597256192;10126.392416455037;10280.177585793268;10311.639092631722;10531.21015923824;10123.392596444237;10189.84715229287;10324.948375258076;10432.695913010873;10581.470926453492;7232.963835180791;7262.854742905218;7303.233160518069;7318.560886346836;7330.5968171751065;8771.561421929006;10098.19214462856;10201.642942496977;10241.283110182216;10282.537285822007 22:44:56 INFO - PROCESS | 20402 | |3;mootools.html;1460.1312219229558;1464.2678660669665;1633.1997321312554;1774.4499205246382;1791.8835275707086;6755.324467553254;7427.3315401613845;7445.590492522909;7616.352610028154;7623.047119110111;7494.437917156208;7496.137944136426;7498.925010749905;7561.319481246686;7562.659680314386;2188.912443502258;2214.6567282071223;2229.1529218896876;2232.0513781642817;2233.9888300558473;2214.0922221889027;2230.531588366445;2230.5984922713906;2233.966490502644;2235.575240704261;2144.1101942693763;2158.686990386393;2165.9025343859485;2175.858569193005;2192.243675931809;2177.4556360909774;2182.71624688791;2195.769444208351;2200.284907405092;2210.027587861344;2115.069369477425;2118.3009606829864;2122.777108403611;2136.0921608316403;2137.551114266006;7654.272844079859;7669.463137580372;7692.692292308301;7702.07575090987;7746.302832745024;4338.717983331074;4458.353538736865;4464.531224221442;4486.3494793254795;4486.439195100613;2842.7725781937397;2893.6093627360456;2962.807417517876;2971.4205729882683;3023.576699262105;909.9317551183622;962.4658314635375;972.6352617768337;977.1449981266392;982.7444864335253;10374.740631484197;10405.583776648926;10409.271351005433;10421.114205292559;10437.11284540815;4095.24238015968;4123.587641235852;4261.70168088237;4266.893327666833;4301.16127355169;8808.339374546935;8850.690225842194;8871.911280887238;8887.822243555092;8891.91108088911;4711.599514041276;4734.26618874075;4738.881527961759;4745.1221524018165;4761.833335833229;3738.2710371477847;4224.704270701021;4321.13577284538;4339.392485052095;4342.522322544518;3696.3716168251462;3739.3456145174487;3790.7156963227867;3822.9426558601085;3863.8840834775;1231.8337024501757;1266.202292555684;1277.201748906933;1278.9232646041266;1287.3691890973355;1220.798568236249;1223.07046644549;1232.1251911143188;1237.3442075699893;1253.035162924543;7119.501634885508;7123.964380178066;7158.60627665473;7358.816029599196;7378.040854688856;437.9846705365297;449.12196655538344;450.1402321565859;452.56779775314493;454.6044940901371;5490.313710786152;5491.093969494988;5530.5852061095575;5532;5557.221988921554;8746.475211487332;9238.630454781867;9479.810403791886;9490.430574165572;9515.191208747334;9331.766705832408;9410.670626528039;9450;9538.666146684833;9548.856767148498;7106.18278897923;7393.889091663629;7415.703371865065;7439.776806695808;7509.887351689729;6966.825829354307;6975.128108986377;7065.293470652894;7116.323949224816;7264.89102663471;8574.657013719381;8679.652813887626;8821.338399619926;8850.468971861708;8875.556222188736;8092.797680058045;8356.415050946376;8379.371547134111;8450.408471406943;8904;6385.106085148176;6924.515283930278;7084.964575177091;7157.642117894188;7288.781336559911;7078.823029424306;7113.57318560888;7120;7137.072180616487;7183.676734546853;6282.151909492343;6488.318726533646;6495.902561461677;6515.674216289071;6527.738890444329;6517.543771935919;6527.902081468686;6553.639549824806;6563.474922006323;6628.436582890508;6891.241963384124;6938.444924406136;6962.582245065312;6972.58164510131;7001.684924178526;6202.844928876814;6208.689565521796;6219.813405597839;6224.408681175281;6428;6286.528510361833;6338.397852204218;6372.840678983062;6420.101185833893;6444.709988050456 22:44:56 INFO - PROCESS | 20402 | |4;prototype.html;294.4023632026986;305.2095073758964;306.9340091880248;306.98158110513367;310.4350082849215;5176.4823517648265;5288.735563221838;5372.3553173619175;5403.648762830423;5428.294321738178;5235.345581802275;5307.840764777063;5322.787088516455;5334.386545547263;5371.650842695231;3869.419587061935;3966.7818269995137;4102.835886564534;4126.855560055391;4133.958660413403;4059.309917314049;4071.8167682454214;4074.5517993020744;4079.571644977279;4086.9182616347803;4051.230266249418;4056.797160141996;4058.8376464941366;4071.1654110907343;4079.2861249281405;3840.711946603988;4060.6345428911245;4062.593740625943;4068.4304197412384;4073.8389558975846;3503.544539209912;3503.6146023937345;3506.403911335079;3519.6480351964856;3524.7004004659634;5075.238714192864;5076.82231121909;5078.974605126988;5081.949180508184;5099.6685215460875;4693.366395536593;4694.624430045588;4694.694844835075;4698.38920940279;4701.717896926195;5349.304590403222;5475.780968761244;5496.615236933416;5505.697186654733;5544;3756.624337566249;3790.9620903790883;3795.1081495848453;3797.2405518896053;3807.733458657895;5819.24349834523;5870.148828419898;5872.853178670567;5879.8530036749;5889.1755154278435;3802.9049273767823;3879.478339079621;3881.301365754135;3890.4164375343926;3893;3898.705593773257;3918.1184233547224;3936.940945885814;3938.1729836734607;3945.427912952663;4572.588467037983;4572.9314060289125;4604.286335617984;4619.630429565626;4622.352870598119;5401.351837779492;5592.133219351007;5611.9719401403545;5617.241672374177;5641.492265696107;1395.114102544871;1407.8944079193896;1415.2852809331223;1417.7518934186476;1420.3963315590834;871.6295574380863;880.8678698195322;883.3992884838243;886.472548833456;908.1508789282043;4671.369365135663;4750.14497390473;4899.118158731391;4921.114199444063;4955.702657840469;5762.222100016528;5782.248307720053;5844.444777746107;5845.824625261249;5854.2096816930025;4635.629149668019;4893.241547560134;4915.680480768739;4958.7024778513405;4963.230699241623;3059.449299126134;3095.9845200773852;3096.6284045914635;3114.283714745621;3118.750499959998;5502.284702988666;5517.834464966058;5526.668399896019;5544.362398324163;5550.944490555043;5868.618539794899;5960.880782384328;5989.131575921467;6006.459418652343;6034.969825150846;5446.665566936047;5464.224127158689;5470.097433923438;5481.616286859881;5486.780528778804;5686.862627474439;5791.971040144772;5793.246877905845;5794.594378393641;5839.532837372915;5714.457126572969;5719.714014299185;5737.9139312911175;5746.683932383759;5760.539156867524;5460.7542660579575;5468.7539060741565;5513.696746678971;5528.806491772769;5531.474509921551;3768.2275133598096;3942.89598912305;4004.9599504004586;4039.2123535910214;4042.8584999524874;5720.799772007959;5769.91345129815;5784.566157538117;5801.941980580309;5808.970955145197;5569;5583.302087239095;5588.6646801192055;5589.469000444951;5592.944070559405;5406.540444062299;5549.667019978814;5571.916421253765;5573.108302671553;5579.246801681883;5449.945500545103;5488.4785945335125;5498.945010550004;5499.257600223918;5510.338759348904;5302.575793936553;5386.946130538645;5591.245181900392;5629.380768115422;5642.181883626933;5491.423400542885;5509.256250406304;5517.420670829505;5525;5551.666899986014 22:44:56 INFO - PROCESS | 20402 | |5;yui.html;655.8360409897525;709.1808960650447;733.5598640815508;759.3128218961838;763.6372722956596;11456.140789440795;11657;11663.300201987877;11708.356040417773;11746.823797643032;11742.178047536676;12486.750264994695;12488.375581220926;12495.062870284719;12546.309952952584;652.1977967100469;805.1465446626595;815.7511958852548;826.9751907442786;832.7585000349891;825.6202147012382;828.5939889454154;828.7969447485375;831.8086840026798;832.097174565597;860.0883063952199;861.5864385095158;863.1842908451516;863.3266052479077;863.4689665855517;861.0270394454258;864.8789169516273;867.1935100356666;867.3581549653243;867.9175478329548;630.9400606942334;631.6241836107508;632.3992207402986;632.4497687012329;634.7016902056026;12946.87053129466;12982.285974271412;13123.475060997549;13213.867861321456;13237.669058273621;12548.24710517372;12549.93725031369;12585.433655485525;12682.365881705879;12810.460107951692;9098.499582522958;9140.405873618194;9441.812030712053;9749.122578967856;9935.205183585296;3933.331333673282;3949.881503554898;3963.9009024774323;4014.698897582693;4053.9594604053877;41352.1729565407;42357.576424235674;42368.57631423708;42471.999999999694;42789;9262.490563018964;9476.573554190078;9623.903760962301;9627.374220675634;9717.12545870875;16016.919915400349;16077.356905723875;16078.356865725475;16095.919520402324;16109.919450402673;6700.932990670129;6862.553933994274;6936.132983377078;6938.479614028968;7018.543794653331;3829.7127715421457;3902.6487616114687;3902.66827319681;3923.0780766519847;3982.38273067675;2749.6837863645937;2931.750801181881;3064.923376915595;3065.8773649053787;3070.7543396528226;554.6976897590823;565.6492974355925;572.3503823160743;573.4523530028813;575.9164921086419;489.77715139611394;588.9487265231542;594.2393736017904;599.9280086389574;640.7308930249307;7959.721409750631;8240.62917168729;8815.911840881508;8927.508987005647;8995;535.5929493584904;592.7006861534898;608.428077607048;616.6515918506029;633.5090305013559;3869.1101046759404;3913.1195481016543;3917.8432862685745;3949.19041596472;4025.19496100781;47221;47376;47577;47669.284960725614;48574.75712621414;43371.34942975858;43719.12561748747;44189.116217675466;44244.336334955;44422.11155776931;39555.208895821925;39726.60273397287;39766.20467590632;40013.39979900304;40028.799856000536;7606.239376062349;7639.159692433716;7680.769576912701;7700.884486732815;7727.652255648622;27357.452850943268;27408.725912741415;27424.314392140357;27816.304592385353;28155.57766633543;34879.651203488655;35891.820540897126;35952.28095438129;36204.27591448209;36670.449943250336;9675.129238368581;9721.416714997124;9769.951150244488;9958.800823983625;10069.144122749649;10672.608104867977;10711.143108551141;10766.94399553099;10864.239503234698;10872.075873550837;10098.798024039625;10132.138768204784;10183.49082545855;10286.228532859916;10294.742631433974;10255.699398499904;10421.426821524889;10493.317934334244;10572.69160085438;10688.465576720977;9878;9911.801763964537;10442.425666588411;10455.215858810467;10628.309159904582;8558.358123140664;8723.476591404537;8848.1151884811;9021.45871247701;9076.546172691471;8822.117788221127;8827.470351778913;8895.510746908723;8907.777305567413;8996.775080622774 22:44:56 INFO - PROCESS | 20402 | __end_tp_report 22:44:56 INFO - PROCESS | 20402 | __start_cc_report 22:44:56 INFO - PROCESS | 20402 | _x_x_mozilla_cycle_collect,373 22:44:56 INFO - PROCESS | 20402 | __end_cc_report 22:44:56 INFO - PROCESS | 20402 | __startTimestamp1460094296890__endTimestamp 22:44:56 INFO - PROCESS | 20402 | 22:44:56 INFO - PROCESS | 20402 | ------- Summary: start ------- 22:44:56 INFO - PROCESS | 20402 | Number of tests: 6 22:44:56 INFO - PROCESS | 20402 | 22:44:56 INFO - PROCESS | 20402 | [#0] dojo.html Cycles:165 Average:4744.58 Median:4831.54 stddev:477.10 (9.9%) stddev-sans-first:449.19 22:44:56 INFO - PROCESS | 20402 | Values: 2643.8 2735.5 2759.8 2765.5 2771.1 4661.9 4701.5 4716.2 4739.4 4764.8 4688.7 4729.4 4821.7 4868.2 4877.9 4367.6 4420.6 4447.2 4522.5 4591.9 4436.0 4447.5 4474.9 4487.2 4547.3 4349.0 4408.4 4414.9 4427.9 4448.7 4426.9 4435.2 4436.5 4447.7 4505.8 4259.0 4388.0 4413.0 4430.7 4464.8 4711.8 4728.3 4749.5 4755.8 4791.4 5150.8 5151.5 5176.3 5182.1 5205.1 5148.1 5178.5 5216.2 5229.7 5254.2 4736.0 4743.6 4754.0 4757.6 4795.8 5186.9 5203.6 5207.5 5218.3 5259.5 4764.9 4979.9 5011.6 5039.5 5062.0 4992.3 5099.9 5150.2 5150.2 5244.7 5119.7 5121.1 5129.6 5130.2 5131.0 4922.7 5057.7 5095.3 5143.2 5151.2 4401.5 4425.6 4426.4 4430.6 4472.1 3810.8 3842.9 3849.2 3890.8 3898.2 4400.6 4450.9 4503.7 4536.9 4547.7 5145.5 5171.5 5177.9 5199.1 5248.5 4331.3 4465.1 4467.5 4477.5 4514.9 4641.7 4699.8 4702.3 4739.8 4742.2 4820.1 4825.9 4845.4 4866.3 4917.8 5012.9 5079.2 5158.5 5160.2 5226.7 4778.0 4792.0 4793.3 4795.3 4831.5 4989.6 4996.8 5001.0 5013.3 5065.6 4976.9 5087.1 5094.3 5128.3 5185.5 4805.4 4865.0 4949.4 5036.2 5083.2 4971.1 4978.9 4980.9 5003.1 5018.9 4755.8 4923.9 4924.6 4931.5 4932.8 4933.3 4935.6 4967.5 4978.6 4987.9 4897.0 4904.6 4913.3 4925.9 4964.3 22:44:56 INFO - PROCESS | 20402 | 22:44:56 INFO - PROCESS | 20402 | [#1] ext.html Cycles:180 Average:43545.09 Median:176652.30 stddev:73772.10 (41.8%) stddev-sans-first:73908.43 22:44:56 INFO - PROCESS | 20402 | Values: 552.7 586.2 593.2 608.7 634.7 35726.5 36712.5 36892.0 36910.0 37001.3 36372.0 36643.8 36663.5 36868.8 37020.8 7632.9 7698.7 7765.6 7785.3 7800.7 7555.8 7561.8 7607.5 7643.6 7666.2 7615.4 7636.4 7667.0 7693.2 7725.2 7594.3 7645.8 7647.2 7665.0 7681.9 7689.9 7694.5 7736.2 7782.9 7791.0 33911.5 34262.5 34263.5 34293.5 34380.1 2907.2 3047.3 3211.6 3438.8 3728.5 27763.6 28082.3 28151.9 28447.7 28639.9 3467.7 3485.3 3486.0 3501.6 3531.5 231394.0 232015.0 232072.8 232626.0 233297.0 51226.0 51304.7 51551.7 51562.0 51776.7 57795.0 59031.3 59170.1 59181.7 59234.7 14966.3 15105.9 15188.3 15237.4 15269.2 11424.5 11578.1 11583.9 11622.7 11648.9 17600.3 17691.3 17722.5 18350.0 18748.4 6842.5 7079.0 7120.0 7151.9 7171.9 825.4 922.9 1010.4 1013.8 1094.5 27521.0 27652.0 27779.4 28368.7 28517.0 1006.3 1009.1 1010.7 1019.3 1041.3 14856.8 14927.8 15162.2 15341.5 15372.9 340948.0 346600.0 347857.0 349803.0 351446.0 48122.3 48585.3 49029.8 49086.5 49193.5 1216.7 1244.3 1253.7 1257.1 1262.5 25799.0 27636.6 27697.9 27838.7 28011.3 42404.4 43149.0 43227.4 43299.1 43308.4 249729.0 250580.0 250675.0 251570.0 252191.0 24887.4 25009.2 25201.5 25203.5 25434.5 42186.6 42313.9 42835.4 42976.0 43029.4 35909.3 35995.8 36228.8 36275.3 36508.8 35182.3 35345.8 35578.3 35671.0 35868.3 31424.5 34827.1 35660.5 35967.6 36851.0 28287.7 28926.3 29011.3 29029.4 29165.4 23191.4 23726.2 24855.8 24941.8 25018.5 22:44:56 INFO - PROCESS | 20402 | 22:44:56 INFO - PROCESS | 20402 | [#2] jquery.html Cycles:180 Average:23708.72 Median:44911.21 stddev:64450.29 (143.5%) stddev-sans-first:64607.25 22:44:56 INFO - PROCESS | 20402 | Values: 362.3 364.5 365.3 376.8 384.3 14004.2 14890.9 16877.7 16877.7 16899.6 16254.7 16732.2 17344.6 17506.3 17587.1 5011.6 5193.7 5205.1 5233.9 5242.8 3751.3 5118.5 5555.4 5908.1 5940.9 5862.4 5879.9 5881.2 5885.0 5902.7 5622.3 5864.9 5903.3 5932.7 5933.8 4424.3 5149.7 5168.8 5171.9 5175.0 18408.5 18518.3 18891.7 18942.6 19403.9 1715.7 1732.5 1764.9 1788.8 1957.3 8643.2 8754.6 8863.4 8882.9 11726.9 1648.3 1668.8 1714.5 1718.3 1740.1 65383.6 68617.3 69514.7 70462.3 70724.0 9873.8 9912.5 9952.5 10057.7 10181.3 14003.6 14038.7 14094.2 14105.5 14166.4 7097.4 7458.9 7548.3 7705.7 7774.5 7279.8 7323.9 7348.6 7367.4 7379.7 4241.8 4274.3 4282.0 4348.5 4355.6 1599.3 1697.9 1712.9 1767.0 1795.9 894.8 904.4 906.4 947.9 954.7 15941.5 16266.3 16426.0 16715.7 16806.5 878.9 883.4 921.2 922.4 970.0 9227.0 9290.7 9298.1 9328.8 9553.8 384695.0 386455.0 388902.0 396214.0 402079.0 43235.0 71116.6 75175.2 75191.0 76450.6 920.0 920.4 935.3 945.1 961.7 14839.9 14853.6 15021.3 15035.8 15096.4 31506.5 32353.7 32923.8 33081.0 33389.3 44313.3 45509.1 45691.8 45753.8 45762.8 7089.2 7147.4 7155.6 7182.8 7250.3 9940.6 10985.2 11231.0 11285.1 11404.7 9731.6 9855.0 9921.0 9923.4 10448.2 10026.8 10126.4 10280.2 10311.6 10531.2 10123.4 10189.8 10324.9 10432.7 10581.5 7233.0 7262.9 7303.2 7318.6 7330.6 8771.6 10098.2 10201.6 10241.3 10282.5 22:44:56 INFO - PROCESS | 20402 | 22:44:56 INFO - PROCESS | 20402 | [#3] mootools.html Cycles:180 Average:5346.82 Median:6312.46 stddev:2810.55 (44.5%) stddev-sans-first:2803.25 22:44:56 INFO - PROCESS | 20402 | Values: 1460.1 1464.3 1633.2 1774.4 1791.9 6755.3 7427.3 7445.6 7616.4 7623.0 7494.4 7496.1 7498.9 7561.3 7562.7 2188.9 2214.7 2229.2 2232.1 2234.0 2214.1 2230.5 2230.6 2234.0 2235.6 2144.1 2158.7 2165.9 2175.9 2192.2 2177.5 2182.7 2195.8 2200.3 2210.0 2115.1 2118.3 2122.8 2136.1 2137.6 7654.3 7669.5 7692.7 7702.1 7746.3 4338.7 4458.4 4464.5 4486.3 4486.4 2842.8 2893.6 2962.8 2971.4 3023.6 909.9 962.5 972.6 977.1 982.7 10374.7 10405.6 10409.3 10421.1 10437.1 4095.2 4123.6 4261.7 4266.9 4301.2 8808.3 8850.7 8871.9 8887.8 8891.9 4711.6 4734.3 4738.9 4745.1 4761.8 3738.3 4224.7 4321.1 4339.4 4342.5 3696.4 3739.3 3790.7 3822.9 3863.9 1231.8 1266.2 1277.2 1278.9 1287.4 1220.8 1223.1 1232.1 1237.3 1253.0 7119.5 7124.0 7158.6 7358.8 7378.0 438.0 449.1 450.1 452.6 454.6 5490.3 5491.1 5530.6 5532.0 5557.2 8746.5 9238.6 9479.8 9490.4 9515.2 9331.8 9410.7 9450.0 9538.7 9548.9 7106.2 7393.9 7415.7 7439.8 7509.9 6966.8 6975.1 7065.3 7116.3 7264.9 8574.7 8679.7 8821.3 8850.5 8875.6 8092.8 8356.4 8379.4 8450.4 8904.0 6385.1 6924.5 7085.0 7157.6 7288.8 7078.8 7113.6 7120.0 7137.1 7183.7 6282.2 6488.3 6495.9 6515.7 6527.7 6517.5 6527.9 6553.6 6563.5 6628.4 6891.2 6938.4 6962.6 6972.6 7001.7 6202.8 6208.7 6219.8 6224.4 6428.0 6286.5 6338.4 6372.8 6420.1 6444.7 22:44:56 INFO - PROCESS | 20402 | 22:44:56 INFO - PROCESS | 20402 | [#4] prototype.html Cycles:180 Average:4606.41 Median:5328.59 stddev:1379.71 (25.9%) stddev-sans-first:1345.09 22:44:56 INFO - PROCESS | 20402 | Values: 294.4 305.2 306.9 307.0 310.4 5176.5 5288.7 5372.4 5403.6 5428.3 5235.3 5307.8 5322.8 5334.4 5371.7 3869.4 3966.8 4102.8 4126.9 4134.0 4059.3 4071.8 4074.6 4079.6 4086.9 4051.2 4056.8 4058.8 4071.2 4079.3 3840.7 4060.6 4062.6 4068.4 4073.8 3503.5 3503.6 3506.4 3519.6 3524.7 5075.2 5076.8 5079.0 5081.9 5099.7 4693.4 4694.6 4694.7 4698.4 4701.7 5349.3 5475.8 5496.6 5505.7 5544.0 3756.6 3791.0 3795.1 3797.2 3807.7 5819.2 5870.1 5872.9 5879.9 5889.2 3802.9 3879.5 3881.3 3890.4 3893.0 3898.7 3918.1 3936.9 3938.2 3945.4 4572.6 4572.9 4604.3 4619.6 4622.4 5401.4 5592.1 5612.0 5617.2 5641.5 1395.1 1407.9 1415.3 1417.8 1420.4 871.6 880.9 883.4 886.5 908.2 4671.4 4750.1 4899.1 4921.1 4955.7 5762.2 5782.2 5844.4 5845.8 5854.2 4635.6 4893.2 4915.7 4958.7 4963.2 3059.4 3096.0 3096.6 3114.3 3118.8 5502.3 5517.8 5526.7 5544.4 5550.9 5868.6 5960.9 5989.1 6006.5 6035.0 5446.7 5464.2 5470.1 5481.6 5486.8 5686.9 5792.0 5793.2 5794.6 5839.5 5714.5 5719.7 5737.9 5746.7 5760.5 5460.8 5468.8 5513.7 5528.8 5531.5 3768.2 3942.9 4005.0 4039.2 4042.9 5720.8 5769.9 5784.6 5801.9 5809.0 5569.0 5583.3 5588.7 5589.5 5592.9 5406.5 5549.7 5571.9 5573.1 5579.2 5449.9 5488.5 5498.9 5499.3 5510.3 5302.6 5386.9 5591.2 5629.4 5642.2 5491.4 5509.3 5517.4 5525.0 5551.7 22:44:56 INFO - PROCESS | 20402 | 22:44:56 INFO - PROCESS | 20402 | [#5] yui.html Cycles:180 Average:12106.60 Median:47476.50 stddev:13316.51 (28.0%) stddev-sans-first:13326.09 22:44:56 INFO - PROCESS | 20402 | Values: 655.8 709.2 733.6 759.3 763.6 11456.1 11657.0 11663.3 11708.4 11746.8 11742.2 12486.8 12488.4 12495.1 12546.3 652.2 805.1 815.8 827.0 832.8 825.6 828.6 828.8 831.8 832.1 860.1 861.6 863.2 863.3 863.5 861.0 864.9 867.2 867.4 867.9 630.9 631.6 632.4 632.4 634.7 12946.9 12982.3 13123.5 13213.9 13237.7 12548.2 12549.9 12585.4 12682.4 12810.5 9098.5 9140.4 9441.8 9749.1 9935.2 3933.3 3949.9 3963.9 4014.7 4054.0 41352.2 42357.6 42368.6 42472.0 42789.0 9262.5 9476.6 9623.9 9627.4 9717.1 16016.9 16077.4 16078.4 16095.9 16109.9 6700.9 6862.6 6936.1 6938.5 7018.5 3829.7 3902.6 3902.7 3923.1 3982.4 2749.7 2931.8 3064.9 3065.9 3070.8 554.7 565.6 572.4 573.5 575.9 489.8 588.9 594.2 599.9 640.7 7959.7 8240.6 8815.9 8927.5 8995.0 535.6 592.7 608.4 616.7 633.5 3869.1 3913.1 3917.8 3949.2 4025.2 47221.0 47376.0 47577.0 47669.3 48574.8 43371.3 43719.1 44189.1 44244.3 44422.1 39555.2 39726.6 39766.2 40013.4 40028.8 7606.2 7639.2 7680.8 7700.9 7727.7 27357.5 27408.7 27424.3 27816.3 28155.6 34879.7 35891.8 35952.3 36204.3 36670.4 9675.1 9721.4 9770.0 9958.8 10069.1 10672.6 10711.1 10766.9 10864.2 10872.1 10098.8 10132.1 10183.5 10286.2 10294.7 10255.7 10421.4 10493.3 10572.7 10688.5 9878.0 9911.8 10442.4 10455.2 10628.3 8558.4 8723.5 8848.1 9021.5 9076.5 8822.1 8827.5 8895.5 8907.8 8996.8 22:44:56 INFO - PROCESS | 20402 | -------- Summary: end -------- 22:44:56 INFO - PROCESS | 20402 | 22:44:57 INFO - TEST-INFO | 20402: exit 0 22:44:57 INFO - TEST-OK | dromaeo_css | took 1115659ms 22:44:57 INFO - TEST-START | kraken 22:44:57 INFO - operating with platform_type : linux_ 22:44:57 INFO - Initialising browser for kraken test... 22:44:57 INFO - TEST-INFO | started process 20636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9sd60v/profile http://localhost:56793/getInfo.html) 22:45:01 INFO - PROCESS | 20636 | 22:45:01 INFO - PROCESS | 20636 | (process:20704): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:45:02 INFO - PROCESS | 20636 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 22:45:02 INFO - PROCESS | 20636 | __metrics Screen width/height:1600/1200 22:45:02 INFO - PROCESS | 20636 | colorDepth:24 22:45:02 INFO - PROCESS | 20636 | Browser inner width/height: 1024/697 22:45:02 INFO - PROCESS | 20636 | __metrics 22:45:03 ERROR - PROCESS | 20636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 22:45:04 INFO - TEST-INFO | 20636: exit 0 22:45:04 INFO - Browser initialized. 22:45:04 INFO - Running cycle 1/1 for kraken test... 22:45:04 INFO - TEST-INFO | started process 20755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9sd60v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:45:06 INFO - PROCESS | 20755 | 22:45:06 INFO - PROCESS | 20755 | (process:20815): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:45:16 INFO - PROCESS | 20755 | RSS: Main: 164315136 22:45:16 INFO - PROCESS | 20755 | 22:45:19 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:56793/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56793/tests/kraken/driver.html?testName=audio-beat-detection) 22:45:19 INFO - PROCESS | 20755 | RSS: Main: 168976384 22:45:19 INFO - PROCESS | 20755 | 22:45:22 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:56793/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56793/tests/kraken/driver.html?testName=audio-dft) 22:45:23 INFO - PROCESS | 20755 | RSS: Main: 172290048 22:45:23 INFO - PROCESS | 20755 | 22:45:26 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:56793/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56793/tests/kraken/driver.html?testName=audio-fft) 22:45:26 INFO - PROCESS | 20755 | RSS: Main: 163074048 22:45:26 INFO - PROCESS | 20755 | 22:45:28 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:56793/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56793/tests/kraken/driver.html?testName=audio-oscillator) 22:45:29 INFO - PROCESS | 20755 | RSS: Main: 163618816 22:45:29 INFO - PROCESS | 20755 | 22:45:31 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:56793/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56793/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:45:32 INFO - PROCESS | 20755 | RSS: Main: 164069376 22:45:32 INFO - PROCESS | 20755 | 22:45:35 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:56793/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56793/tests/kraken/driver.html?testName=imaging-darkroom) 22:45:36 INFO - PROCESS | 20755 | RSS: Main: 163966976 22:45:36 INFO - PROCESS | 20755 | 22:45:39 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:56793/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56793/tests/kraken/driver.html?testName=imaging-desaturate) 22:45:40 INFO - PROCESS | 20755 | RSS: Main: 164372480 22:45:40 INFO - PROCESS | 20755 | 22:45:43 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:56793/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56793/tests/kraken/driver.html?testName=json-parse-financial) 22:45:43 INFO - PROCESS | 20755 | RSS: Main: 164708352 22:45:43 INFO - PROCESS | 20755 | 22:45:45 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:56793/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56793/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:45:46 INFO - PROCESS | 20755 | RSS: Main: 165113856 22:45:46 INFO - PROCESS | 20755 | 22:45:48 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:56793/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56793/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:45:48 INFO - PROCESS | 20755 | RSS: Main: 165281792 22:45:48 INFO - PROCESS | 20755 | 22:45:50 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:56793/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56793/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:45:51 INFO - PROCESS | 20755 | RSS: Main: 165515264 22:45:51 INFO - PROCESS | 20755 | 22:45:54 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:56793/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:45:54 INFO - PROCESS | 20755 | RSS: Main: 165752832 22:45:54 INFO - PROCESS | 20755 | 22:45:57 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:56793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:45:58 INFO - PROCESS | 20755 | RSS: Main: 166187008 22:45:58 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | Cycle 1(1): loaded http://localhost:56793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56793/tests/kraken/driver.html?testName=ai-astar) 22:46:00 INFO - PROCESS | 20755 | RSS: Main: 166735872 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | __start_tp_report 22:46:00 INFO - PROCESS | 20755 | _x_x_mozilla_page_load 22:46:00 INFO - PROCESS | 20755 | _x_x_mozilla_page_load_details 22:46:00 INFO - PROCESS | 20755 | |i|pagename|runs| 22:46:00 INFO - PROCESS | 20755 | |0;ai-astar;115;108;115;113;114;126;115;114;113;112 22:46:00 INFO - PROCESS | 20755 | |1;audio-beat-detection;162;141;156;187;136;165;159;134;170;136 22:46:00 INFO - PROCESS | 20755 | |2;audio-dft;164;163;162;162;165;175;165;163;165;165 22:46:00 INFO - PROCESS | 20755 | |3;audio-fft;73;73;75;74;73;73;74;164;74;74 22:46:00 INFO - PROCESS | 20755 | |4;audio-oscillator;95;94;141;95;94;93;140;94;94;141 22:46:00 INFO - PROCESS | 20755 | |5;imaging-gaussian-blur;118;117;118;117;118;117;128;118;118;118 22:46:00 INFO - PROCESS | 20755 | |6;imaging-darkroom;147;148;147;147;148;148;147;146;146;147 22:46:00 INFO - PROCESS | 20755 | |7;imaging-desaturate;97;96;96;96;96;98;96;96;96;96 22:46:00 INFO - PROCESS | 20755 | |8;json-parse-financial;67;65;66;65;66;67;68;66;68;65 22:46:00 INFO - PROCESS | 20755 | |9;json-stringify-tinderbox;65;67;64;65;65;65;65;65;65;66 22:46:00 INFO - PROCESS | 20755 | |10;stanford-crypto-aes;85;85;89;92;86;86;88;84;93;86 22:46:00 INFO - PROCESS | 20755 | |11;stanford-crypto-ccm;148;140;150;146;138;146;147;144;147;153 22:46:00 INFO - PROCESS | 20755 | |12;stanford-crypto-pbkdf2;177;172;174;172;172;169;177;171;169;172 22:46:00 INFO - PROCESS | 20755 | |13;stanford-crypto-sha256-iterative;73;71;70;69;71;70;71;72;71;71 22:46:00 INFO - PROCESS | 20755 | __end_tp_report 22:46:00 INFO - PROCESS | 20755 | __start_cc_report 22:46:00 INFO - PROCESS | 20755 | _x_x_mozilla_cycle_collect,923 22:46:00 INFO - PROCESS | 20755 | __end_cc_report 22:46:00 INFO - PROCESS | 20755 | __startTimestamp1460094360528__endTimestamp 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | ------- Summary: start ------- 22:46:00 INFO - PROCESS | 20755 | Number of tests: 14 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | [#0] ai-astar Cycles:10 Average:114.50 Median:114.50 stddev:4.55 (4.0%) stddev-sans-first:4.82 22:46:00 INFO - PROCESS | 20755 | Values: 115.0 108.0 115.0 113.0 114.0 126.0 115.0 114.0 113.0 112.0 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | [#1] audio-beat-detection Cycles:10 Average:154.60 Median:160.50 stddev:17.55 (10.9%) stddev-sans-first:18.41 22:46:00 INFO - PROCESS | 20755 | Values: 162.0 141.0 156.0 187.0 136.0 165.0 159.0 134.0 170.0 136.0 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:3.75 (2.3%) stddev-sans-first:3.97 22:46:00 INFO - PROCESS | 20755 | Values: 164.0 163.0 162.0 162.0 165.0 175.0 165.0 163.0 165.0 165.0 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | [#3] audio-fft Cycles:10 Average:82.70 Median:74.00 stddev:28.57 (38.6%) stddev-sans-first:30.09 22:46:00 INFO - PROCESS | 20755 | Values: 73.0 73.0 75.0 74.0 73.0 73.0 74.0 164.0 74.0 74.0 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:94.00 stddev:22.48 (23.9%) stddev-sans-first:23.34 22:46:00 INFO - PROCESS | 20755 | Values: 95.0 94.0 141.0 95.0 94.0 93.0 140.0 94.0 94.0 141.0 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:118.00 stddev:3.30 (2.8%) stddev-sans-first:3.49 22:46:00 INFO - PROCESS | 20755 | Values: 118.0 117.0 118.0 117.0 118.0 117.0 128.0 118.0 118.0 118.0 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 22:46:00 INFO - PROCESS | 20755 | Values: 147.0 148.0 147.0 147.0 148.0 148.0 147.0 146.0 146.0 147.0 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 22:46:00 INFO - PROCESS | 20755 | Values: 97.0 96.0 96.0 96.0 96.0 98.0 96.0 96.0 96.0 96.0 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.50 stddev:1.16 (1.7%) stddev-sans-first:1.20 22:46:00 INFO - PROCESS | 20755 | Values: 67.0 65.0 66.0 65.0 66.0 67.0 68.0 66.0 68.0 65.0 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 22:46:00 INFO - PROCESS | 20755 | Values: 65.0 67.0 64.0 65.0 65.0 65.0 65.0 65.0 65.0 66.0 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.00 stddev:3.06 (3.5%) stddev-sans-first:3.12 22:46:00 INFO - PROCESS | 20755 | Values: 85.0 85.0 89.0 92.0 86.0 86.0 88.0 84.0 93.0 86.0 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:147.00 stddev:4.41 (3.0%) stddev-sans-first:4.61 22:46:00 INFO - PROCESS | 20755 | Values: 148.0 140.0 150.0 146.0 138.0 146.0 147.0 144.0 147.0 153.0 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:172.00 stddev:2.80 (1.6%) stddev-sans-first:2.45 22:46:00 INFO - PROCESS | 20755 | Values: 177.0 172.0 174.0 172.0 172.0 169.0 177.0 171.0 169.0 172.0 22:46:00 INFO - PROCESS | 20755 | 22:46:00 INFO - PROCESS | 20755 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:1.10 (1.6%) stddev-sans-first:0.87 22:46:00 INFO - PROCESS | 20755 | Values: 73.0 71.0 70.0 69.0 71.0 70.0 71.0 72.0 71.0 71.0 22:46:00 INFO - PROCESS | 20755 | -------- Summary: end -------- 22:46:00 INFO - PROCESS | 20755 | 22:46:01 INFO - TEST-INFO | 20755: exit 0 22:46:01 INFO - TEST-OK | kraken | took 63909ms 22:46:01 INFO - SUITE-END | took 1179s 22:46:01 INFO - Completed test suite (00:19:39) 22:46:01 INFO - javascript benchmark 22:46:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2643.7884969202464, 2735.53495905696, 2759.765419939305, 2765.4745598336312, 2771.127094965085, 4661.930071048929, 4701.459332176796, 4716.198246298129, 4739.4075740532435, 4764.809407623699, 4688.671792974493, 4729.432468103823, 4821.710697358161, 4868.221084626461, 4877.926831097528, 4367.5632436756305, 4420.624246938998, 4447.221736196169, 4522.47991480979, 4591.885202869921, 4435.977820110895, 4447.466304043519, 4474.8881277967985, 4487.214737420954, 4547.317902314646, 4349.043210493686, 4408.3607876858, 4414.933775993362, 4427.889302767457, 4448.7108337957925, 4426.889327766799, 4435.246008178618, 4436.511983681792, 4447.666425018137, 4505.752183629899, 4258.977845317133, 4387.9561204387865, 4412.955870441318, 4430.712003719748, 4464.776761161961, 4711.764411779397, 4728.267118596623, 4749.453812811502, 4755.762211889391, 4791.4250289965075, 5150.793968241266, 5151.5363617274625, 5176.301199338079, 5182.144946083891, 5205.063088644042, 5148.099082660557, 5178.482151784791, 5216.150407153113, 5229.738513074331, 5254.21186821976, 4736.0, 4743.620510359163, 4754.049190161947, 4757.595604373632, 4795.832145874878, 5186.870328241824, 5203.583713303003, 5207.479252074762, 5218.269442278084, 5259.474052594786, 4764.880877978009, 4979.850604481871, 5011.57401620859, 5039.4708555601865, 5062.038212739568, 4992.276119962585, 5099.898002040012, 5150.150225212873, 5150.201718733602, 5244.659097158673, 5119.718415487109, 5121.129408000649, 5129.589632829365, 5130.1535246684625, 5131.0, 4922.729249891218, 5057.671251368649, 5095.261187127846, 5143.151380022255, 5151.150060240094, 4401.515833258339, 4425.557444255549, 4426.392490120542, 4430.645548356124, 4472.060867217856, 3810.8475660973804, 3842.9039274018373, 3849.172427928009, 3890.844366225376, 3898.2398432305995, 4400.647948164139, 4450.888727781831, 4503.662225333113, 4536.931946020813, 4547.681662283609, 5145.4854514549, 5171.4828517148735, 5177.870553236124, 5199.142141546678, 5248.527632513092, 4331.328644060112, 4465.0623369092855, 4467.508574056851, 4477.485089214717, 4514.932276015862, 4641.744704041243, 4699.812007519661, 4702.3416721659, 4739.786709598007, 4742.217534106902, 4820.108279968217, 4825.9034819304115, 4845.394325709286, 4866.29438731389, 4917.803287868517, 5012.949870501394, 5079.238114282887, 5158.484151584811, 5160.200168973815, 5226.660267082628, 4777.95222047789, 4792.0, 4793.281007848851, 4795.328653988375, 4831.541003604652, 4989.60083193351, 4996.800127994985, 5000.974995125001, 5013.273075404119, 5065.620078494054, 4976.8755781105765, 5087.109755792648, 5094.286799848099, 5128.282040514257, 5185.481451854785, 4805.399325084364, 4865.0, 4949.430815456269, 5036.219385995177, 5083.212102124176, 4971.105201063843, 4978.8755281118265, 4980.850574482772, 5003.124453220599, 5018.874528136826, 4755.7859896305445, 4923.876903077452, 4924.581410580141, 4931.457539670561, 4932.753362331798, 4933.284673722362, 4935.555799978019, 4967.503249675004, 4978.576820970258, 4987.925181122214, 4897.0, 4904.632152588499, 4913.3121363008495, 4925.926111108264, 4964.255361695775], "value": 4715.547391065275, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.7043031977893, 586.1705686453669, 593.1814096546765, 608.7230310208854, 634.6636282770133, 35726.464103038474, 36712.51231133038, 36892.0, 36910.0, 37001.25997480049, 36372.0, 36643.81678091606, 36663.450048249295, 36868.81565592175, 37020.81489592555, 7632.885506717404, 7698.730544430946, 7765.572893490856, 7785.260400261966, 7800.7269745558915, 7555.7733268001775, 7561.848763024736, 7607.543547387147, 7643.61781910905, 7666.156722760492, 7615.428842836809, 7636.389088872905, 7667.0, 7693.153753087156, 7725.150233474314, 7594.278543538355, 7645.808854778619, 7647.235276472364, 7665.041869766279, 7681.923180768176, 7689.884651730228, 7694.4998575092995, 7736.226377362275, 7782.922170778276, 7790.961045194795, 33911.49132763011, 34262.48606270883, 34263.4860477093, 34293.485597716055, 34380.14049648754, 2907.215051935965, 3047.2686555226805, 3211.6467188609236, 3438.8108654024018, 3728.5152930119184, 27763.583546246824, 28082.297942551395, 28151.859240703667, 28447.71552284492, 28639.856800715865, 3467.7225821934435, 3485.2506711057245, 3485.9825700871334, 3501.5973163086314, 3531.5408996830247, 231394.0, 232015.0, 232072.83963580243, 232626.0, 233297.0, 51226.0, 51304.743476283125, 51551.74224128856, 51562.0, 51776.74111629418, 57795.0, 59031.34358953858, 59170.11244831331, 59181.70409147927, 59234.70382648059, 14966.251687415586, 15105.924470377797, 15188.316525756147, 15237.3905043797, 15269.160196189094, 11424.543018279343, 11578.073754099652, 11583.884161158448, 11622.70943226426, 11648.88351116478, 17600.295988160586, 17691.292348306182, 17722.46832595024, 18350.0, 18748.437546873614, 6842.521023528405, 7079.0, 7120.0, 7151.923403659968, 7171.89242161368, 825.3603457320504, 922.9446233226028, 1010.434156872154, 1013.7871047080196, 1094.480121942071, 27521.0, 27652.0, 27779.444411111665, 28368.71631283661, 28517.0, 1006.3207335048813, 1009.1422291052546, 1010.722051435861, 1019.261035749076, 1041.3439533094102, 14856.777148342784, 14927.776083358758, 15162.24188790556, 15341.463048793239, 15372.923135384252, 340948.0, 346600.0, 347857.0, 349803.0, 351446.0, 48122.27816582684, 48585.27122093172, 49029.754851225516, 49086.50913490819, 49193.50806491961, 1216.671498695365, 1244.3467179730715, 1253.7429826885466, 1257.126297223421, 1262.4571434283346, 25799.0, 27636.585451217845, 27697.861510692317, 27838.747256373917, 28011.299717507227, 42404.363934540386, 43149.0, 43227.35158972555, 43299.134017318844, 43308.35037474377, 249729.0, 250580.0, 250675.0, 251570.0, 252191.0, 24887.37781555403, 25009.249722508353, 25201.49597008013, 25203.495930081663, 25434.491310173322, 42186.57813421949, 42313.88430578521, 42835.357469638606, 42976.0, 43029.35455968226, 35909.28181436409, 35995.82002089973, 36228.81885590555, 36275.27449450943, 36508.81745591255, 35182.29635407226, 35345.823270883484, 35578.28843423065, 35671.0, 35868.28263434769, 31424.528632070993, 34827.129321767155, 35660.46509302415, 35967.64032359643, 36851.0, 28287.717122828508, 28926.276843079093, 29011.27471813137, 29029.41941161207, 29165.416691666473, 23191.420214494774, 23726.204576917808, 24855.751442485343, 24941.750582494667, 25018.499630006932], "value": 17245.573359953425, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.34234863722344, 364.5479605289442, 365.30409569769586, 376.83230962221825, 384.30904022301866, 14004.229767362804, 14890.851091489081, 16877.746833797504, 16877.746833797504, 16899.57751056224, 16254.674906501863, 16732.16339183042, 17344.566385840328, 17506.299748010064, 17587.12064396778, 5011.624128190382, 5193.714345710984, 5205.089109405858, 5233.86915327118, 5242.842714718565, 3751.3247615429214, 5118.513741194581, 5555.444455554432, 5908.1433192187105, 5940.851478713023, 5862.443067908542, 5879.8530036749, 5881.206037184968, 5885.0, 5902.704864756745, 5622.32532096149, 5864.941350586482, 5903.291605007405, 5932.7330270137945, 5933.821985340447, 4424.292113261895, 5149.665271757323, 5168.844934651929, 5171.870703232449, 5175.0, 18408.53978650531, 18518.259269629198, 18891.716624250646, 18942.62114757697, 19403.90298048515, 1715.6825987192285, 1732.5235560220915, 1764.876458647895, 1788.8300611441891, 1957.3442896629647, 8643.17889800468, 8754.606042728028, 8863.423877447945, 8882.911170888337, 11726.941365293203, 1648.2582837722953, 1668.758030085643, 1714.485654303704, 1718.3126749300254, 1740.1125426032688, 65383.619745514814, 68617.31382686159, 69514.65242673804, 70462.2953770466, 70724.0, 9873.802523949624, 9912.504374781232, 9952.502374881227, 10057.748556286006, 10181.287309888237, 14003.649908752363, 14038.719225615634, 14094.154350738989, 14105.506307279402, 14166.433342666383, 7097.396721278646, 7458.850822983619, 7548.320651141424, 7705.691772329044, 7774.494657847335, 7279.781606551706, 7323.9267607323245, 7348.63256837156, 7367.447441441914, 7379.6679149438405, 4241.766702831374, 4274.316109422478, 4281.97859010703, 4348.478182618106, 4355.62797718724, 1599.3362754457003, 1697.915104244783, 1712.8715346349074, 1766.9734953975444, 1795.89224646519, 894.8165626046645, 904.4347282948157, 906.4334790755778, 947.9146876780985, 954.7088138117801, 15941.521754347388, 16266.268017938984, 16426.0, 16715.6656866862, 16806.495805125865, 878.9208971192623, 883.4346018548134, 921.1617428140494, 922.3820040572832, 970.0348153587225, 9226.953865230631, 9290.674826381044, 9298.070192980784, 9328.766780830398, 9553.808923821623, 384695.0, 386455.0, 388902.0, 396214.0, 402079.0, 43235.0, 71116.64441677759, 75175.24824751791, 75191.0, 76450.61774691091, 919.9586018629178, 920.3879420185635, 935.2611436964858, 945.1399226703667, 961.6682244625453, 14839.851601483848, 14853.554393367784, 15021.324040418425, 15035.849641503444, 15096.423667084568, 31506.527402089447, 32353.676463235068, 32923.8353808239, 33081.0, 33389.33221335511, 44313.33529996988, 45509.08981820411, 45691.77154114208, 45753.771231144965, 45762.77118614386, 7089.184743754328, 7147.356737893407, 7155.606441645759, 7182.820429489305, 7250.347468727628, 9940.602375904882, 10985.231033827555, 11231.0, 11285.097192224766, 11404.657860264206, 9731.56207970629, 9854.950725246328, 9920.950395247977, 9923.354981926152, 10448.216383771096, 10026.849597256192, 10126.392416455037, 10280.177585793268, 10311.639092631722, 10531.21015923824, 10123.392596444237, 10189.84715229287, 10324.948375258076, 10432.695913010873, 10581.470926453492, 7232.963835180791, 7262.854742905218, 7303.233160518069, 7318.560886346836, 7330.5968171751065, 8771.561421929006, 10098.19214462856, 10201.642942496977, 10241.283110182216, 10282.537285822007], "value": 8065.995031678502, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.1312219229558, 1464.2678660669665, 1633.1997321312554, 1774.4499205246382, 1791.8835275707086, 6755.324467553254, 7427.3315401613845, 7445.590492522909, 7616.352610028154, 7623.047119110111, 7494.437917156208, 7496.137944136426, 7498.925010749905, 7561.319481246686, 7562.659680314386, 2188.912443502258, 2214.6567282071223, 2229.1529218896876, 2232.0513781642817, 2233.9888300558473, 2214.0922221889027, 2230.531588366445, 2230.5984922713906, 2233.966490502644, 2235.575240704261, 2144.1101942693763, 2158.686990386393, 2165.9025343859485, 2175.858569193005, 2192.243675931809, 2177.4556360909774, 2182.71624688791, 2195.769444208351, 2200.284907405092, 2210.027587861344, 2115.069369477425, 2118.3009606829864, 2122.777108403611, 2136.0921608316403, 2137.551114266006, 7654.272844079859, 7669.463137580372, 7692.692292308301, 7702.07575090987, 7746.302832745024, 4338.717983331074, 4458.353538736865, 4464.531224221442, 4486.3494793254795, 4486.439195100613, 2842.7725781937397, 2893.6093627360456, 2962.807417517876, 2971.4205729882683, 3023.576699262105, 909.9317551183622, 962.4658314635375, 972.6352617768337, 977.1449981266392, 982.7444864335253, 10374.740631484197, 10405.583776648926, 10409.271351005433, 10421.114205292559, 10437.11284540815, 4095.24238015968, 4123.587641235852, 4261.70168088237, 4266.893327666833, 4301.16127355169, 8808.339374546935, 8850.690225842194, 8871.911280887238, 8887.822243555092, 8891.91108088911, 4711.599514041276, 4734.26618874075, 4738.881527961759, 4745.1221524018165, 4761.833335833229, 3738.2710371477847, 4224.704270701021, 4321.13577284538, 4339.392485052095, 4342.522322544518, 3696.3716168251462, 3739.3456145174487, 3790.7156963227867, 3822.9426558601085, 3863.8840834775, 1231.8337024501757, 1266.202292555684, 1277.201748906933, 1278.9232646041266, 1287.3691890973355, 1220.798568236249, 1223.07046644549, 1232.1251911143188, 1237.3442075699893, 1253.035162924543, 7119.501634885508, 7123.964380178066, 7158.60627665473, 7358.816029599196, 7378.040854688856, 437.9846705365297, 449.12196655538344, 450.1402321565859, 452.56779775314493, 454.6044940901371, 5490.313710786152, 5491.093969494988, 5530.5852061095575, 5532.0, 5557.221988921554, 8746.475211487332, 9238.630454781867, 9479.810403791886, 9490.430574165572, 9515.191208747334, 9331.766705832408, 9410.670626528039, 9450.0, 9538.666146684833, 9548.856767148498, 7106.18278897923, 7393.889091663629, 7415.703371865065, 7439.776806695808, 7509.887351689729, 6966.825829354307, 6975.128108986377, 7065.293470652894, 7116.323949224816, 7264.89102663471, 8574.657013719381, 8679.652813887626, 8821.338399619926, 8850.468971861708, 8875.556222188736, 8092.797680058045, 8356.415050946376, 8379.371547134111, 8450.408471406943, 8904.0, 6385.106085148176, 6924.515283930278, 7084.964575177091, 7157.642117894188, 7288.781336559911, 7078.823029424306, 7113.57318560888, 7120.0, 7137.072180616487, 7183.676734546853, 6282.151909492343, 6488.318726533646, 6495.902561461677, 6515.674216289071, 6527.738890444329, 6517.543771935919, 6527.902081468686, 6553.639549824806, 6563.474922006323, 6628.436582890508, 6891.241963384124, 6938.444924406136, 6962.582245065312, 6972.58164510131, 7001.684924178526, 6202.844928876814, 6208.689565521796, 6219.813405597839, 6224.408681175281, 6428.0, 6286.528510361833, 6338.397852204218, 6372.840678983062, 6420.101185833893, 6444.709988050456], "value": 4312.201926577604, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.4023632026986, 305.2095073758964, 306.9340091880248, 306.98158110513367, 310.4350082849215, 5176.4823517648265, 5288.735563221838, 5372.3553173619175, 5403.648762830423, 5428.294321738178, 5235.345581802275, 5307.840764777063, 5322.787088516455, 5334.386545547263, 5371.650842695231, 3869.419587061935, 3966.7818269995137, 4102.835886564534, 4126.855560055391, 4133.958660413403, 4059.309917314049, 4071.8167682454214, 4074.5517993020744, 4079.571644977279, 4086.9182616347803, 4051.230266249418, 4056.797160141996, 4058.8376464941366, 4071.1654110907343, 4079.2861249281405, 3840.711946603988, 4060.6345428911245, 4062.593740625943, 4068.4304197412384, 4073.8389558975846, 3503.544539209912, 3503.6146023937345, 3506.403911335079, 3519.6480351964856, 3524.7004004659634, 5075.238714192864, 5076.82231121909, 5078.974605126988, 5081.949180508184, 5099.6685215460875, 4693.366395536593, 4694.624430045588, 4694.694844835075, 4698.38920940279, 4701.717896926195, 5349.304590403222, 5475.780968761244, 5496.615236933416, 5505.697186654733, 5544.0, 3756.624337566249, 3790.9620903790883, 3795.1081495848453, 3797.2405518896053, 3807.733458657895, 5819.24349834523, 5870.148828419898, 5872.853178670567, 5879.8530036749, 5889.1755154278435, 3802.9049273767823, 3879.478339079621, 3881.301365754135, 3890.4164375343926, 3893.0, 3898.705593773257, 3918.1184233547224, 3936.940945885814, 3938.1729836734607, 3945.427912952663, 4572.588467037983, 4572.9314060289125, 4604.286335617984, 4619.630429565626, 4622.352870598119, 5401.351837779492, 5592.133219351007, 5611.9719401403545, 5617.241672374177, 5641.492265696107, 1395.114102544871, 1407.8944079193896, 1415.2852809331223, 1417.7518934186476, 1420.3963315590834, 871.6295574380863, 880.8678698195322, 883.3992884838243, 886.472548833456, 908.1508789282043, 4671.369365135663, 4750.14497390473, 4899.118158731391, 4921.114199444063, 4955.702657840469, 5762.222100016528, 5782.248307720053, 5844.444777746107, 5845.824625261249, 5854.2096816930025, 4635.629149668019, 4893.241547560134, 4915.680480768739, 4958.7024778513405, 4963.230699241623, 3059.449299126134, 3095.9845200773852, 3096.6284045914635, 3114.283714745621, 3118.750499959998, 5502.284702988666, 5517.834464966058, 5526.668399896019, 5544.362398324163, 5550.944490555043, 5868.618539794899, 5960.880782384328, 5989.131575921467, 6006.459418652343, 6034.969825150846, 5446.665566936047, 5464.224127158689, 5470.097433923438, 5481.616286859881, 5486.780528778804, 5686.862627474439, 5791.971040144772, 5793.246877905845, 5794.594378393641, 5839.532837372915, 5714.457126572969, 5719.714014299185, 5737.9139312911175, 5746.683932383759, 5760.539156867524, 5460.7542660579575, 5468.7539060741565, 5513.696746678971, 5528.806491772769, 5531.474509921551, 3768.2275133598096, 3942.89598912305, 4004.9599504004586, 4039.2123535910214, 4042.8584999524874, 5720.799772007959, 5769.91345129815, 5784.566157538117, 5801.941980580309, 5808.970955145197, 5569.0, 5583.302087239095, 5588.6646801192055, 5589.469000444951, 5592.944070559405, 5406.540444062299, 5549.667019978814, 5571.916421253765, 5573.108302671553, 5579.246801681883, 5449.945500545103, 5488.4785945335125, 5498.945010550004, 5499.257600223918, 5510.338759348904, 5302.575793936553, 5386.946130538645, 5591.245181900392, 5629.380768115422, 5642.181883626933, 5491.423400542885, 5509.256250406304, 5517.420670829505, 5525.0, 5551.666899986014], "value": 4158.58399665415, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.8360409897525, 709.1808960650447, 733.5598640815508, 759.3128218961838, 763.6372722956596, 11456.140789440795, 11657.0, 11663.300201987877, 11708.356040417773, 11746.823797643032, 11742.178047536676, 12486.750264994695, 12488.375581220926, 12495.062870284719, 12546.309952952584, 652.1977967100469, 805.1465446626595, 815.7511958852548, 826.9751907442786, 832.7585000349891, 825.6202147012382, 828.5939889454154, 828.7969447485375, 831.8086840026798, 832.097174565597, 860.0883063952199, 861.5864385095158, 863.1842908451516, 863.3266052479077, 863.4689665855517, 861.0270394454258, 864.8789169516273, 867.1935100356666, 867.3581549653243, 867.9175478329548, 630.9400606942334, 631.6241836107508, 632.3992207402986, 632.4497687012329, 634.7016902056026, 12946.87053129466, 12982.285974271412, 13123.475060997549, 13213.867861321456, 13237.669058273621, 12548.24710517372, 12549.93725031369, 12585.433655485525, 12682.365881705879, 12810.460107951692, 9098.499582522958, 9140.405873618194, 9441.812030712053, 9749.122578967856, 9935.205183585296, 3933.331333673282, 3949.881503554898, 3963.9009024774323, 4014.698897582693, 4053.9594604053877, 41352.1729565407, 42357.576424235674, 42368.57631423708, 42471.999999999694, 42789.0, 9262.490563018964, 9476.573554190078, 9623.903760962301, 9627.374220675634, 9717.12545870875, 16016.919915400349, 16077.356905723875, 16078.356865725475, 16095.919520402324, 16109.919450402673, 6700.932990670129, 6862.553933994274, 6936.132983377078, 6938.479614028968, 7018.543794653331, 3829.7127715421457, 3902.6487616114687, 3902.66827319681, 3923.0780766519847, 3982.38273067675, 2749.6837863645937, 2931.750801181881, 3064.923376915595, 3065.8773649053787, 3070.7543396528226, 554.6976897590823, 565.6492974355925, 572.3503823160743, 573.4523530028813, 575.9164921086419, 489.77715139611394, 588.9487265231542, 594.2393736017904, 599.9280086389574, 640.7308930249307, 7959.721409750631, 8240.62917168729, 8815.911840881508, 8927.508987005647, 8995.0, 535.5929493584904, 592.7006861534898, 608.428077607048, 616.6515918506029, 633.5090305013559, 3869.1101046759404, 3913.1195481016543, 3917.8432862685745, 3949.19041596472, 4025.19496100781, 47221.0, 47376.0, 47577.0, 47669.284960725614, 48574.75712621414, 43371.34942975858, 43719.12561748747, 44189.116217675466, 44244.336334955, 44422.11155776931, 39555.208895821925, 39726.60273397287, 39766.20467590632, 40013.39979900304, 40028.799856000536, 7606.239376062349, 7639.159692433716, 7680.769576912701, 7700.884486732815, 7727.652255648622, 27357.452850943268, 27408.725912741415, 27424.314392140357, 27816.304592385353, 28155.57766633543, 34879.651203488655, 35891.820540897126, 35952.28095438129, 36204.27591448209, 36670.449943250336, 9675.129238368581, 9721.416714997124, 9769.951150244488, 9958.800823983625, 10069.144122749649, 10672.608104867977, 10711.143108551141, 10766.94399553099, 10864.239503234698, 10872.075873550837, 10098.798024039625, 10132.138768204784, 10183.49082545855, 10286.228532859916, 10294.742631433974, 10255.699398499904, 10421.426821524889, 10493.317934334244, 10572.69160085438, 10688.465576720977, 9878.0, 9911.801763964537, 10442.425666588411, 10455.215858810467, 10628.309159904582, 8558.358123140664, 8723.476591404537, 8848.1151884811, 9021.45871247701, 9076.546172691471, 8822.117788221127, 8827.470351778913, 8895.510746908723, 8907.777305567413, 8996.775080622774], "value": 5847.935315333236, "unit": "score"}], "name": "dromaeo_css", "value": 6401.175178385966, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 115.0, 113.0, 114.0, 126.0, 115.0, 114.0, 113.0, 112.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 141.0, 156.0, 187.0, 136.0, 165.0, 159.0, 134.0, 170.0, 136.0], "value": 154.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 162.0, 165.0, 175.0, 165.0, 163.0, 165.0, 165.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 75.0, 74.0, 73.0, 73.0, 74.0, 164.0, 74.0, 74.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 141.0, 95.0, 94.0, 93.0, 140.0, 94.0, 94.0, 141.0], "value": 108.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 128.0, 118.0, 118.0, 118.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 146.0, 146.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 65.0, 66.0, 67.0, 68.0, 66.0, 68.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 89.0, 92.0, 86.0, 86.0, 88.0, 84.0, 93.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 140.0, 150.0, 146.0, 138.0, 146.0, 147.0, 144.0, 147.0, 153.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 172.0, 174.0, 172.0, 172.0, 169.0, 177.0, 171.0, 169.0, 172.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 70.0, 69.0, 71.0, 70.0, 71.0, 72.0, 71.0, 71.0], "value": 70.9, "unit": "score"}], "name": "kraken", "value": 1595.1000000000004, "alertThreshold": 2.0}]} 22:46:01 INFO - Return code: 0 22:46:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:46:01 ERROR - # TBPL SUCCESS # 22:46:01 INFO - Running post-action listener: _resource_record_post_action 22:46:01 INFO - Running post-run listener: _resource_record_post_run 22:46:02 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 518770688; Read time: 24; Write time: 441424 22:46:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233369600; Read time: 0; Write time: 244552 22:46:02 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 285401088; Read time: 24; Write time: 196872 22:46:02 INFO - Running post-run listener: _upload_blobber_files 22:46:02 INFO - Blob upload gear active. 22:46:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:46:02 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 22:46:02 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'] 22:46:02 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 22:46:03 INFO - (blobuploader) - INFO - Open directory for files ... 22:46:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:46:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:46:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:46:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:46:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:46:04 INFO - (blobuploader) - INFO - Done attempting. 22:46:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:46:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:46:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:46:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:46:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:46:05 INFO - (blobuploader) - INFO - Done attempting. 22:46:05 INFO - (blobuploader) - INFO - Iteration through files over. 22:46:05 INFO - Return code: 0 22:46:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:46:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:46:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec4551c5b424dd15eb92788286d3c8d41cd59226f8413ceb4e1e241daaa2448861fdaa41acf8da83c55b252f0aafcbda8c8e5e4c479d1a0336e25316294eae4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/49326b3c8fa38c3e57e17f86178901c63c548a048c42996610958fd67dfff49634a229dc6bde52096755abfb9ef2668ddc77ee4379d57d9fd82ca69f6df640e7"} 22:46:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:46:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:46:05 INFO - Contents: 22:46:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec4551c5b424dd15eb92788286d3c8d41cd59226f8413ceb4e1e241daaa2448861fdaa41acf8da83c55b252f0aafcbda8c8e5e4c479d1a0336e25316294eae4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/49326b3c8fa38c3e57e17f86178901c63c548a048c42996610958fd67dfff49634a229dc6bde52096755abfb9ef2668ddc77ee4379d57d9fd82ca69f6df640e7"} 22:46:05 INFO - Running post-run listener: copy_logs_to_upload_dir 22:46:05 INFO - Copying logs to upload dir... 22:46:05 INFO - mkdir: /builds/slave/test/build/upload/logs 22:46:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.722809 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-07 22:46:04.946313) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 22:46:04.949753) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec4551c5b424dd15eb92788286d3c8d41cd59226f8413ceb4e1e241daaa2448861fdaa41acf8da83c55b252f0aafcbda8c8e5e4c479d1a0336e25316294eae4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/49326b3c8fa38c3e57e17f86178901c63c548a048c42996610958fd67dfff49634a229dc6bde52096755abfb9ef2668ddc77ee4379d57d9fd82ca69f6df640e7"} build_url:https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/OBipYVyDR6u3kKmj7QpCxQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ec4551c5b424dd15eb92788286d3c8d41cd59226f8413ceb4e1e241daaa2448861fdaa41acf8da83c55b252f0aafcbda8c8e5e4c479d1a0336e25316294eae4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/49326b3c8fa38c3e57e17f86178901c63c548a048c42996610958fd67dfff49634a229dc6bde52096755abfb9ef2668ddc77ee4379d57d9fd82ca69f6df640e7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 22:46:04.978494) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:46:04.979177) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1460090667.838764-868703377 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 22:46:05.062278) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 22:46:05.063094) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 22:46:05.063859) ========= ========= Total master_lag: 0.27 =========