builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1456794591.44 results: success (0) buildid: 20160229162331 builduid: 8547eb2a6e6f44baa4971d92ae134f19 revision: 1a61474707944169a43fddb94b3cf6da565df8dd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:51.440049) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:51.440497) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:51.440829) ========= 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=6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006517 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:51.467611) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:51.467942) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:51.485725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:51.486056) ========= 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=6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:51.534720) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:51.535041) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:51.535421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:51.535736) ========= 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=6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 17:09:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 85.3M=0s 2016-02-29 17:09:51 (85.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115487 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:51.663781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:51.664117) ========= 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=6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020060 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:51.715258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:51.715655) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1a61474707944169a43fddb94b3cf6da565df8dd --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 1a61474707944169a43fddb94b3cf6da565df8dd --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=6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 17:09:51,939 truncating revision to first 12 chars 2016-02-29 17:09:51,939 Setting DEBUG logging. 2016-02-29 17:09:51,939 attempt 1/10 2016-02-29 17:09:51,939 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1a6147470794?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 17:09:52,220 unpacking tar archive at: fx-team-1a6147470794/testing/mozharness/ program finished with exit code 0 elapsedTime=0.587152 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:52.316619) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:52.317043) ========= echo 1a61474707944169a43fddb94b3cf6da565df8dd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1a61474707944169a43fddb94b3cf6da565df8dd'] 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=6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1a61474707944169a43fddb94b3cf6da565df8dd program finished with exit code 0 elapsedTime=0.004722 script_repo_revision: '1a61474707944169a43fddb94b3cf6da565df8dd' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:52.366992) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:52.367339) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 17:09:52.379414) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-29 17:09:52.379998) ========= /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=6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:09:52 INFO - MultiFileLogger online at 20160229 17:09:52 in /builds/slave/test 17:09:52 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 17:09:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:09:52 INFO - {'append_to_log': False, 17:09:52 INFO - 'base_work_dir': '/builds/slave/test', 17:09:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:09:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:09:52 INFO - 'branch': 'Fx-Team-Non-PGO', 17:09:52 INFO - 'buildbot_json_path': 'buildprops.json', 17:09:52 INFO - 'config_files': ('talos/linux_config.py',), 17:09:52 INFO - 'default_actions': ('clobber', 17:09:52 INFO - 'read-buildbot-config', 17:09:52 INFO - 'download-and-extract', 17:09:52 INFO - 'populate-webroot', 17:09:52 INFO - 'create-virtualenv', 17:09:52 INFO - 'install', 17:09:52 INFO - 'run-tests'), 17:09:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:09:52 INFO - 'download_minidump_stackwalk': True, 17:09:52 INFO - 'download_symbols': 'ondemand', 17:09:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:09:52 INFO - 'tooltool.py': '/tools/tooltool.py', 17:09:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:09:52 INFO - '/tools/misc-python/virtualenv.py')}, 17:09:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:09:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:09:52 INFO - 'installer_path': 'installer.exe', 17:09:52 INFO - 'log_level': 'info', 17:09:52 INFO - 'log_name': 'talos', 17:09:52 INFO - 'log_to_console': True, 17:09:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:09:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:09:52 INFO - 'opt_config_files': (), 17:09:52 INFO - 'pip_index': False, 17:09:52 INFO - 'sps_profile': False, 17:09:52 INFO - 'sps_profile_interval': 0, 17:09:52 INFO - 'suite': 'dromaeojs-e10s', 17:09:52 INFO - 'system_bits': '32', 17:09:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:09:52 INFO - 'title': 'talos-linux64-ix-023', 17:09:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:09:52 INFO - 'use_talos_json': True, 17:09:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:09:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:09:52 INFO - 'work_dir': 'build'} 17:09:52 INFO - ##### 17:09:52 INFO - ##### Running clobber step. 17:09:52 INFO - ##### 17:09:52 INFO - Running pre-action listener: _resource_record_pre_action 17:09:52 INFO - Running main action method: clobber 17:09:52 INFO - rmtree: /builds/slave/test/build 17:09:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:09:53 INFO - Running post-action listener: _resource_record_post_action 17:09:53 INFO - ##### 17:09:53 INFO - ##### Running read-buildbot-config step. 17:09:53 INFO - ##### 17:09:53 INFO - Running pre-action listener: _resource_record_pre_action 17:09:53 INFO - Running main action method: read_buildbot_config 17:09:53 INFO - Using buildbot properties: 17:09:53 INFO - { 17:09:53 INFO - "project": "", 17:09:53 INFO - "product": "firefox", 17:09:53 INFO - "script_repo_revision": "production", 17:09:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:09:53 INFO - "repository": "", 17:09:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 17:09:53 INFO - "buildid": "20160229162331", 17:09:53 INFO - "pgo_build": "False", 17:09:53 INFO - "basedir": "/builds/slave/test", 17:09:53 INFO - "buildnumber": 992, 17:09:53 INFO - "slavename": "talos-linux64-ix-023", 17:09:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:09:53 INFO - "platform": "ubuntu64_hw", 17:09:53 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:09:53 INFO - "branch": "fx-team", 17:09:53 INFO - "repo_path": "integration/fx-team", 17:09:53 INFO - "revision": "1a61474707944169a43fddb94b3cf6da565df8dd", 17:09:53 INFO - "stage_platform": "linux64", 17:09:53 INFO - "builduid": "8547eb2a6e6f44baa4971d92ae134f19", 17:09:53 INFO - "slavebuilddir": "test" 17:09:53 INFO - } 17:09:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 17:09:53 INFO - Running post-action listener: _resource_record_post_action 17:09:53 INFO - ##### 17:09:53 INFO - ##### Running download-and-extract step. 17:09:53 INFO - ##### 17:09:53 INFO - Running pre-action listener: _resource_record_pre_action 17:09:53 INFO - Running main action method: download_and_extract 17:09:53 INFO - mkdir: /builds/slave/test/build/tests 17:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:53 INFO - https://queue.taskcluster.net/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:09:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/test_packages.json 17:09:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/test_packages.json 17:09:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:09:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:09:53 INFO - Downloaded 1448 bytes. 17:09:53 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:09:53 INFO - Using the following test package requirements: 17:09:53 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:53 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:09:53 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:09:53 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:53 INFO - u'jsshell-linux-x86_64.zip'], 17:09:53 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:09:53 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:53 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:09:53 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:09:53 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:09:53 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:53 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:53 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:09:53 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:53 INFO - https://queue.taskcluster.net/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:09:54 INFO - Downloaded 22065168 bytes. 17:09:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:09:55 INFO - Return code: 0 17:09:55 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:09: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')]} 17:09:55 INFO - https://queue.taskcluster.net/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:10:00 INFO - Downloaded 22065168 bytes. 17:10:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:10:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:10:01 INFO - Return code: 0 17:10: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')]} 17:10:01 INFO - https://queue.taskcluster.net/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:10:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:10:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:10:02 INFO - Downloaded 10713410 bytes. 17:10:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:10:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:10:03 INFO - Return code: 0 17:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:03 INFO - https://queue.taskcluster.net/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:10:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:10:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:10:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:10:04 INFO - Downloaded 54835849 bytes. 17:10:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:10:04 INFO - mkdir: /builds/slave/test/properties 17:10:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:10:04 INFO - Writing to file /builds/slave/test/properties/build_url 17:10:04 INFO - Contents: 17:10:04 INFO - build_url:https://queue.taskcluster.net/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:10:05 INFO - Running post-action listener: _resource_record_post_action 17:10:05 INFO - Running post-action listener: set_extra_try_arguments 17:10:05 INFO - ##### 17:10:05 INFO - ##### Running populate-webroot step. 17:10:05 INFO - ##### 17:10:05 INFO - Running pre-action listener: _resource_record_pre_action 17:10:05 INFO - Running main action method: populate_webroot 17:10:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:10:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:10:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:10:05 INFO - '--tppagecycles', 17:10:05 INFO - '7'], 17:10:05 INFO - 'tests': ['tsvgm']}}, 17:10:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:10:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:10:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:10:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:10:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:10:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:10:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:05 INFO - 'talos_options': ['--e10s'], 17:10:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:10:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:05 INFO - 'tests': ['damp', 'tps']}, 17:10:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:05 INFO - 'talos_options': ['--e10s'], 17:10:05 INFO - 'tests': ['damp', 'tps']}, 17:10:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:10:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:10:05 INFO - 'other': {'tests': ['a11yr', 17:10:05 INFO - 'ts_paint', 17:10:05 INFO - 'tpaint', 17:10:05 INFO - 'sessionrestore', 17:10:05 INFO - 'sessionrestore_no_auto_restore']}, 17:10:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:10:05 INFO - 'tests': ['a11yr', 17:10:05 INFO - 'ts_paint', 17:10:05 INFO - 'tpaint', 17:10:05 INFO - 'sessionrestore', 17:10:05 INFO - 'sessionrestore_no_auto_restore']}, 17:10:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:10:05 INFO - 'tests': ['a11yr', 17:10:05 INFO - 'ts_paint', 17:10:05 INFO - 'tpaint', 17:10:05 INFO - 'sessionrestore', 17:10:05 INFO - 'sessionrestore_no_auto_restore']}, 17:10:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:10:05 INFO - 'tests': ['a11yr', 17:10:05 INFO - 'ts_paint', 17:10:05 INFO - 'tpaint', 17:10:05 INFO - 'sessionrestore', 17:10:05 INFO - 'sessionrestore_no_auto_restore']}, 17:10:05 INFO - 'other_l64': {'tests': ['a11yr', 17:10:05 INFO - 'ts_paint', 17:10:05 INFO - 'tpaint', 17:10:05 INFO - 'sessionrestore', 17:10:05 INFO - 'sessionrestore_no_auto_restore']}, 17:10:05 INFO - 'other_nol64': {'tests': ['a11yr', 17:10:05 INFO - 'ts_paint', 17:10:05 INFO - 'tpaint', 17:10:05 INFO - 'sessionrestore', 17:10:05 INFO - 'sessionrestore_no_auto_restore']}, 17:10:05 INFO - 'svgr': {'tests': ['tsvgx', 17:10:05 INFO - 'tsvgr_opacity', 17:10:05 INFO - 'tart', 17:10:05 INFO - 'tscrollx', 17:10:05 INFO - 'cart']}, 17:10:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:10:05 INFO - 'tests': ['tsvgx', 17:10:05 INFO - 'tsvgr_opacity', 17:10:05 INFO - 'tart', 17:10:05 INFO - 'tscrollx', 17:10:05 INFO - 'cart']}, 17:10:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:05 INFO - 'tests': ['tp5o']}, 17:10:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:05 INFO - 'talos_options': ['--e10s'], 17:10:05 INFO - 'tests': ['tp5o']}, 17:10:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:05 INFO - 'talos_options': ['--xperf_path', 17:10:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:05 INFO - 'tests': ['tp5n']}, 17:10:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:10:05 INFO - 'talos_options': ['--e10s', 17:10:05 INFO - '--xperf_path', 17:10:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:10:05 INFO - 'tests': ['tp5n']}}, 17:10:05 INFO - 'talos.zip': {'path': '', 17:10:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:10:05 INFO - Running post-action listener: _resource_record_post_action 17:10:05 INFO - ##### 17:10:05 INFO - ##### Running create-virtualenv step. 17:10:05 INFO - ##### 17:10:05 INFO - Running pre-action listener: _resource_record_pre_action 17:10:05 INFO - Running main action method: create_virtualenv 17:10:05 INFO - Creating virtualenv /builds/slave/test/build/venv 17:10:05 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 17:10:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:10:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:10:05 INFO - Using real prefix '/usr' 17:10:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:10:06 INFO - Installing distribute.............................................................................................................................................................................................done. 17:10:08 INFO - Installing pip.................done. 17:10:08 INFO - Return code: 0 17:10:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:08 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 0x7fbbe7fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb100>, '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 0x11ec000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ec490>, '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': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', '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 17:10:08 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 17:10:08 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 17:10:08 INFO - Using env: {'DISPLAY': ':0', 17:10:08 INFO - 'HOME': '/home/cltbld', 17:10:08 INFO - 'LANG': 'en_US.UTF-8', 17:10:08 INFO - 'LANGUAGE': 'en_US:en', 17:10:08 INFO - 'LOGNAME': 'cltbld', 17:10:08 INFO - 'MAIL': '/var/mail/cltbld', 17:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:08 INFO - 'MOZ_NO_REMOTE': '1', 17:10:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:08 INFO - 'NO_EM_RESTART': '1', 17:10:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:08 INFO - 'PWD': '/builds/slave/test', 17:10:08 INFO - 'SHELL': '/bin/bash', 17:10:08 INFO - 'SHLVL': '1', 17:10:08 INFO - 'TERM': 'linux', 17:10:08 INFO - 'TMOUT': '86400', 17:10:08 INFO - 'USER': 'cltbld', 17:10:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', 17:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:08 INFO - '_': '/tools/buildbot/bin/python'} 17:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:08 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 17:10:08 INFO - Cleaning up... 17:10:08 INFO - Return code: 0 17:10:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:08 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 0x7fbbe7fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb100>, '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 0x11ec000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ec490>, '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': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', '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 17:10:08 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 17:10:08 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 17:10:08 INFO - Using env: {'DISPLAY': ':0', 17:10:08 INFO - 'HOME': '/home/cltbld', 17:10:08 INFO - 'LANG': 'en_US.UTF-8', 17:10:08 INFO - 'LANGUAGE': 'en_US:en', 17:10:08 INFO - 'LOGNAME': 'cltbld', 17:10:08 INFO - 'MAIL': '/var/mail/cltbld', 17:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:08 INFO - 'MOZ_NO_REMOTE': '1', 17:10:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:08 INFO - 'NO_EM_RESTART': '1', 17:10:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:08 INFO - 'PWD': '/builds/slave/test', 17:10:08 INFO - 'SHELL': '/bin/bash', 17:10:08 INFO - 'SHLVL': '1', 17:10:08 INFO - 'TERM': 'linux', 17:10:08 INFO - 'TMOUT': '86400', 17:10:08 INFO - 'USER': 'cltbld', 17:10:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', 17:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:08 INFO - '_': '/tools/buildbot/bin/python'} 17:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:08 INFO - Downloading/unpacking psutil>=0.7.1 17:10:08 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 17:10:08 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 17:10:08 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 17:10:08 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 17:10:08 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 17:10:08 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 17:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:10:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:10 INFO - Installing collected packages: psutil 17:10:10 INFO - Running setup.py install for psutil 17:10:10 INFO - building 'psutil._psutil_linux' extension 17:10:10 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 17:10:10 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 17:10:10 INFO - building 'psutil._psutil_posix' extension 17:10:10 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 17:10:10 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 17:10:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:10:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:10:10 INFO - Successfully installed psutil 17:10:10 INFO - Cleaning up... 17:10:10 INFO - Return code: 0 17:10:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:10:10 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')]} 17:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:10 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')]} 17:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:10 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 0x7fbbe7fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb100>, '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 0x11ec000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ec490>, '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': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', '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 17:10:10 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 17:10:10 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 17:10:10 INFO - Using env: {'DISPLAY': ':0', 17:10:10 INFO - 'HOME': '/home/cltbld', 17:10:10 INFO - 'LANG': 'en_US.UTF-8', 17:10:10 INFO - 'LANGUAGE': 'en_US:en', 17:10:10 INFO - 'LOGNAME': 'cltbld', 17:10:10 INFO - 'MAIL': '/var/mail/cltbld', 17:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:10 INFO - 'MOZ_NO_REMOTE': '1', 17:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:10 INFO - 'NO_EM_RESTART': '1', 17:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:10 INFO - 'PWD': '/builds/slave/test', 17:10:10 INFO - 'SHELL': '/bin/bash', 17:10:10 INFO - 'SHLVL': '1', 17:10:10 INFO - 'TERM': 'linux', 17:10:10 INFO - 'TMOUT': '86400', 17:10:10 INFO - 'USER': 'cltbld', 17:10:10 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', 17:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:10 INFO - '_': '/tools/buildbot/bin/python'} 17:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:10:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:10:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:10:13 INFO - Installing collected packages: mozsystemmonitor 17:10:13 INFO - Running setup.py install for mozsystemmonitor 17:10:13 INFO - Successfully installed mozsystemmonitor 17:10:13 INFO - Cleaning up... 17:10:13 INFO - Return code: 0 17:10:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:13 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 0x7fbbe7fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb100>, '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 0x11ec000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ec490>, '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': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', '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 17:10:13 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 17:10:13 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 17:10:13 INFO - Using env: {'DISPLAY': ':0', 17:10:13 INFO - 'HOME': '/home/cltbld', 17:10:13 INFO - 'LANG': 'en_US.UTF-8', 17:10:13 INFO - 'LANGUAGE': 'en_US:en', 17:10:13 INFO - 'LOGNAME': 'cltbld', 17:10:13 INFO - 'MAIL': '/var/mail/cltbld', 17:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:13 INFO - 'MOZ_NO_REMOTE': '1', 17:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:13 INFO - 'NO_EM_RESTART': '1', 17:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:13 INFO - 'PWD': '/builds/slave/test', 17:10:13 INFO - 'SHELL': '/bin/bash', 17:10:13 INFO - 'SHLVL': '1', 17:10:13 INFO - 'TERM': 'linux', 17:10:13 INFO - 'TMOUT': '86400', 17:10:13 INFO - 'USER': 'cltbld', 17:10:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', 17:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:13 INFO - '_': '/tools/buildbot/bin/python'} 17:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:13 INFO - Downloading/unpacking blobuploader==1.2.4 17:10:13 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 17:10:13 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 17:10:13 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 17:10:13 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 17:10:13 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 17:10:13 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 17:10:15 INFO - Downloading blobuploader-1.2.4.tar.gz 17:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:10:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:10:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:15 INFO - Downloading docopt-0.6.1.tar.gz 17:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:10:15 INFO - Installing collected packages: blobuploader, requests, docopt 17:10:15 INFO - Running setup.py install for blobuploader 17:10:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:10:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:10:16 INFO - Running setup.py install for requests 17:10:16 INFO - Running setup.py install for docopt 17:10:16 INFO - Successfully installed blobuploader requests docopt 17:10:16 INFO - Cleaning up... 17:10:16 INFO - Return code: 0 17:10:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:16 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 0x7fbbe7fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb100>, '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 0x11ec000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ec490>, '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': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', '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 17:10:16 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 17:10:16 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 17:10:16 INFO - Using env: {'DISPLAY': ':0', 17:10:16 INFO - 'HOME': '/home/cltbld', 17:10:16 INFO - 'LANG': 'en_US.UTF-8', 17:10:16 INFO - 'LANGUAGE': 'en_US:en', 17:10:16 INFO - 'LOGNAME': 'cltbld', 17:10:16 INFO - 'MAIL': '/var/mail/cltbld', 17:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:16 INFO - 'MOZ_NO_REMOTE': '1', 17:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:16 INFO - 'NO_EM_RESTART': '1', 17:10:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:16 INFO - 'PWD': '/builds/slave/test', 17:10:16 INFO - 'SHELL': '/bin/bash', 17:10:16 INFO - 'SHLVL': '1', 17:10:16 INFO - 'TERM': 'linux', 17:10:16 INFO - 'TMOUT': '86400', 17:10:16 INFO - 'USER': 'cltbld', 17:10:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', 17:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:16 INFO - '_': '/tools/buildbot/bin/python'} 17:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:16 INFO - Running setup.py (path:/tmp/pip-WwF75t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:16 INFO - Running setup.py (path:/tmp/pip-KdLu3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:16 INFO - Running setup.py (path:/tmp/pip-0e8EMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:17 INFO - Running setup.py (path:/tmp/pip-OJWrvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:17 INFO - Running setup.py (path:/tmp/pip-HRUmIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:17 INFO - Running setup.py (path:/tmp/pip-M43fXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:17 INFO - Running setup.py (path:/tmp/pip-W9z1oY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:17 INFO - Running setup.py (path:/tmp/pip-H6O3LX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:17 INFO - Running setup.py (path:/tmp/pip-s6I8Od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:17 INFO - Running setup.py (path:/tmp/pip-jp7dcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:17 INFO - Running setup.py (path:/tmp/pip-tQfVUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:17 INFO - Running setup.py (path:/tmp/pip-veQWg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:17 INFO - Running setup.py (path:/tmp/pip-UU1kra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:17 INFO - Running setup.py (path:/tmp/pip-HluNHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:17 INFO - Running setup.py (path:/tmp/pip-vHhcTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:17 INFO - Running setup.py (path:/tmp/pip-ws_9cU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:17 INFO - Running setup.py (path:/tmp/pip-jrnHxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:10:18 INFO - Running setup.py install for manifestparser 17:10:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:10:18 INFO - Running setup.py install for mozcrash 17:10:18 INFO - Running setup.py install for mozdebug 17:10:18 INFO - Running setup.py install for mozdevice 17:10:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:10:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:10:18 INFO - Running setup.py install for mozfile 17:10:18 INFO - Running setup.py install for mozhttpd 17:10:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:10:18 INFO - Running setup.py install for mozinfo 17:10:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:10:18 INFO - Running setup.py install for mozInstall 17:10:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:10:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:10:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:10:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:10:18 INFO - Running setup.py install for mozleak 17:10:18 INFO - Running setup.py install for mozlog 17:10:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:10:19 INFO - Running setup.py install for moznetwork 17:10:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:10:19 INFO - Running setup.py install for mozprocess 17:10:19 INFO - Running setup.py install for mozprofile 17:10:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:10:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:10:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:10:19 INFO - Running setup.py install for mozrunner 17:10:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:10:19 INFO - Running setup.py install for mozscreenshot 17:10:19 INFO - Running setup.py install for moztest 17:10:19 INFO - Running setup.py install for mozversion 17:10:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:10:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:10:19 INFO - Cleaning up... 17:10:19 INFO - Return code: 0 17:10:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:19 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')]} 17:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:19 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')]} 17:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:19 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 0x7fbbe7fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb100>, '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 0x11ec000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ec490>, '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': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', '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 17:10:19 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 17:10:19 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 17:10:19 INFO - Using env: {'DISPLAY': ':0', 17:10:19 INFO - 'HOME': '/home/cltbld', 17:10:19 INFO - 'LANG': 'en_US.UTF-8', 17:10:19 INFO - 'LANGUAGE': 'en_US:en', 17:10:19 INFO - 'LOGNAME': 'cltbld', 17:10:19 INFO - 'MAIL': '/var/mail/cltbld', 17:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:19 INFO - 'MOZ_NO_REMOTE': '1', 17:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:19 INFO - 'NO_EM_RESTART': '1', 17:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:19 INFO - 'PWD': '/builds/slave/test', 17:10:19 INFO - 'SHELL': '/bin/bash', 17:10:19 INFO - 'SHLVL': '1', 17:10:19 INFO - 'TERM': 'linux', 17:10:19 INFO - 'TMOUT': '86400', 17:10:19 INFO - 'USER': 'cltbld', 17:10:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', 17:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:19 INFO - '_': '/tools/buildbot/bin/python'} 17:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:10:20 INFO - Running setup.py (path:/tmp/pip-jkRyKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:10:20 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)) 17:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:10:20 INFO - Running setup.py (path:/tmp/pip-ZVNQSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:10:20 INFO - Running setup.py (path:/tmp/pip-W62KIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:10:20 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)) 17:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:10:20 INFO - Running setup.py (path:/tmp/pip-Y7HZ3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:10:20 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)) 17:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:10:20 INFO - Running setup.py (path:/tmp/pip-NRTKOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:10:20 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)) 17:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:10:20 INFO - Running setup.py (path:/tmp/pip-tXkqjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:20 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)) 17:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:20 INFO - Running setup.py (path:/tmp/pip-XnfpOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:20 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)) 17:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:20 INFO - Running setup.py (path:/tmp/pip-CFesI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:20 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)) 17:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:20 INFO - Running setup.py (path:/tmp/pip-WL5qgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:20 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)) 17:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:20 INFO - Running setup.py (path:/tmp/pip-EoIIkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:20 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)) 17:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:20 INFO - Running setup.py (path:/tmp/pip-hvzhAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:20 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)) 17:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:20 INFO - Running setup.py (path:/tmp/pip-O7ZRGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:20 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)) 17:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:20 INFO - Running setup.py (path:/tmp/pip-7WzBZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:20 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)) 17:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:20 INFO - Running setup.py (path:/tmp/pip-8dfJD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:21 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)) 17:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:21 INFO - Running setup.py (path:/tmp/pip-Mc4Zj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:21 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)) 17:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:21 INFO - Running setup.py (path:/tmp/pip-748von-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:21 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)) 17:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:21 INFO - Running setup.py (path:/tmp/pip-WSISBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:21 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)) 17:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:10:21 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)) 17:10:21 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)) 17:10:21 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)) 17:10:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:23 INFO - Downloading blessings-1.6.tar.gz 17:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:10:23 INFO - Installing collected packages: blessings 17:10:23 INFO - Running setup.py install for blessings 17:10:23 INFO - Successfully installed blessings 17:10:23 INFO - Cleaning up... 17:10:23 INFO - Return code: 0 17:10:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:10:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:23 INFO - Reading from file tmpfile_stdout 17:10:23 INFO - Current package versions: 17:10:23 INFO - argparse == 1.2.1 17:10:23 INFO - blessings == 1.6 17:10:23 INFO - blobuploader == 1.2.4 17:10:23 INFO - docopt == 0.6.1 17:10:23 INFO - manifestparser == 1.1 17:10:23 INFO - mozInstall == 1.12 17:10:23 INFO - mozcrash == 0.16 17:10:23 INFO - mozdebug == 0.1 17:10:23 INFO - mozdevice == 0.48 17:10:23 INFO - mozfile == 1.2 17:10:23 INFO - mozhttpd == 0.7 17:10:23 INFO - mozinfo == 0.9 17:10:23 INFO - mozleak == 0.1 17:10:23 INFO - mozlog == 3.1 17:10:23 INFO - moznetwork == 0.27 17:10:23 INFO - mozprocess == 0.22 17:10:23 INFO - mozprofile == 0.28 17:10:23 INFO - mozrunner == 6.11 17:10:23 INFO - mozscreenshot == 0.1 17:10:23 INFO - mozsystemmonitor == 0.0 17:10:23 INFO - moztest == 0.7 17:10:23 INFO - mozversion == 1.4 17:10:23 INFO - psutil == 3.1.1 17:10:23 INFO - requests == 1.2.3 17:10:23 INFO - wsgiref == 0.1.2 17:10:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10: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')]} 17:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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')]} 17:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:23 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 0x7fbbe7fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb100>, '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 0x11ec000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ec490>, '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': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', '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 17:10:23 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 17:10:23 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 17:10:23 INFO - Using env: {'DISPLAY': ':0', 17:10:23 INFO - 'HOME': '/home/cltbld', 17:10:23 INFO - 'LANG': 'en_US.UTF-8', 17:10:23 INFO - 'LANGUAGE': 'en_US:en', 17:10:23 INFO - 'LOGNAME': 'cltbld', 17:10:23 INFO - 'MAIL': '/var/mail/cltbld', 17:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:23 INFO - 'MOZ_NO_REMOTE': '1', 17:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:23 INFO - 'NO_EM_RESTART': '1', 17:10:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:23 INFO - 'PWD': '/builds/slave/test', 17:10:23 INFO - 'SHELL': '/bin/bash', 17:10:23 INFO - 'SHLVL': '1', 17:10:23 INFO - 'TERM': 'linux', 17:10:23 INFO - 'TMOUT': '86400', 17:10:23 INFO - 'USER': 'cltbld', 17:10:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', 17:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:23 INFO - '_': '/tools/buildbot/bin/python'} 17:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 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)) 17:10:23 INFO - Cleaning up... 17:10:23 INFO - Return code: 0 17:10:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:10: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')]} 17:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10: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')]} 17:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:23 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 0x7fbbe7fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb100>, '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 0x11ec000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ec490>, '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': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', '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 17:10:23 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 17:10:23 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 17:10:23 INFO - Using env: {'DISPLAY': ':0', 17:10:23 INFO - 'HOME': '/home/cltbld', 17:10:23 INFO - 'LANG': 'en_US.UTF-8', 17:10:23 INFO - 'LANGUAGE': 'en_US:en', 17:10:23 INFO - 'LOGNAME': 'cltbld', 17:10:23 INFO - 'MAIL': '/var/mail/cltbld', 17:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:23 INFO - 'MOZ_NO_REMOTE': '1', 17:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:23 INFO - 'NO_EM_RESTART': '1', 17:10:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:23 INFO - 'PWD': '/builds/slave/test', 17:10:23 INFO - 'SHELL': '/bin/bash', 17:10:23 INFO - 'SHLVL': '1', 17:10:23 INFO - 'TERM': 'linux', 17:10:23 INFO - 'TMOUT': '86400', 17:10:23 INFO - 'USER': 'cltbld', 17:10:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', 17:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:23 INFO - '_': '/tools/buildbot/bin/python'} 17:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:24 INFO - Downloading/unpacking jsonschema 17:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:10:25 INFO - Downloading/unpacking functools32 (from jsonschema) 17:10:25 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 17:10:25 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 17:10:25 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 17:10:25 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 17:10:25 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 17:10:25 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 17:10:26 INFO - Downloading functools32-3.2.3-2.tar.gz 17:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:10:26 INFO - warning: no files found matching '*.txt' 17:10:26 INFO - no previously-included directories found matching 'build' 17:10:26 INFO - no previously-included directories found matching 'dist' 17:10:26 INFO - no previously-included directories found matching '.git*' 17:10:26 INFO - Installing collected packages: jsonschema, functools32 17:10:26 INFO - Running setup.py install for functools32 17:10:26 INFO - warning: no files found matching '*.txt' 17:10:26 INFO - no previously-included directories found matching 'build' 17:10:26 INFO - no previously-included directories found matching 'dist' 17:10:26 INFO - no previously-included directories found matching '.git*' 17:10:26 INFO - Successfully installed jsonschema functools32 17:10:26 INFO - Cleaning up... 17:10:26 INFO - Return code: 0 17:10:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbe7fe3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115c3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb100>, '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 0x11ec000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ec490>, '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': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', '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 17:10:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:10:26 INFO - Using env: {'DISPLAY': ':0', 17:10:26 INFO - 'HOME': '/home/cltbld', 17:10:26 INFO - 'LANG': 'en_US.UTF-8', 17:10:26 INFO - 'LANGUAGE': 'en_US:en', 17:10:26 INFO - 'LOGNAME': 'cltbld', 17:10:26 INFO - 'MAIL': '/var/mail/cltbld', 17:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:26 INFO - 'MOZ_NO_REMOTE': '1', 17:10:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:26 INFO - 'NO_EM_RESTART': '1', 17:10:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:26 INFO - 'PWD': '/builds/slave/test', 17:10:26 INFO - 'SHELL': '/bin/bash', 17:10:26 INFO - 'SHLVL': '1', 17:10:26 INFO - 'TERM': 'linux', 17:10:26 INFO - 'TMOUT': '86400', 17:10:26 INFO - 'USER': 'cltbld', 17:10:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', 17:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:26 INFO - '_': '/tools/buildbot/bin/python'} 17:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:26 INFO - Downloading/unpacking flake8 17:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:10:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:10:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:10:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:29 INFO - no previously-included directories found matching 'docs/_build' 17:10:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:10:29 INFO - Running setup.py install for pep8 17:10:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:29 INFO - no previously-included directories found matching 'docs/_build' 17:10:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:10:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:10:29 INFO - Cleaning up... 17:10:29 INFO - Return code: 0 17:10:29 INFO - Running post-action listener: _resource_record_post_action 17:10:29 INFO - Running post-action listener: _start_resource_monitoring 17:10:29 INFO - Starting resource monitoring. 17:10:29 INFO - ##### 17:10:29 INFO - ##### Running install step. 17:10:29 INFO - ##### 17:10:29 INFO - Running pre-action listener: _resource_record_pre_action 17:10:29 INFO - Running main action method: install 17:10:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:29 INFO - Reading from file tmpfile_stdout 17:10:29 INFO - Detecting whether we're running mozinstall >=1.0... 17:10:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:10:29 INFO - Reading from file tmpfile_stdout 17:10:29 INFO - Output received: 17:10:29 INFO - Usage: mozinstall [options] installer 17:10:29 INFO - Options: 17:10:29 INFO - -h, --help show this help message and exit 17:10:29 INFO - -d DEST, --destination=DEST 17:10:29 INFO - Directory to install application into. [default: 17:10:29 INFO - "/builds/slave/test"] 17:10:29 INFO - --app=APP Application being installed. [default: firefox] 17:10:29 INFO - mkdir: /builds/slave/test/build/application 17:10:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:10:45 INFO - Reading from file tmpfile_stdout 17:10:45 INFO - Output received: 17:10:45 INFO - /builds/slave/test/build/application/firefox/firefox 17:10:45 INFO - Running post-action listener: _resource_record_post_action 17:10:45 INFO - ##### 17:10:45 INFO - ##### Running run-tests step. 17:10:45 INFO - ##### 17:10:45 INFO - Running pre-action listener: _resource_record_pre_action 17:10:45 INFO - Running main action method: run_tests 17:10:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:10:45 INFO - Python 2.7.3 17:10:45 INFO - Return code: 0 17:10:45 INFO - grabbing minidump binary from tooltool 17:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:45 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 0x11eb100>, '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 0x11ec000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ec490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:10:45 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 17:10:45 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 17:10:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:10:45 INFO - Return code: 0 17:10:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:10:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:10:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:10:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:10:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:10:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:10:46 INFO - Return code: 0 17:10:46 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/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 17:10:46 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/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 17:10:46 INFO - Using env: {'DISPLAY': ':0', 17:10:46 INFO - 'HOME': '/home/cltbld', 17:10:46 INFO - 'LANG': 'en_US.UTF-8', 17:10:46 INFO - 'LANGUAGE': 'en_US:en', 17:10:46 INFO - 'LOGNAME': 'cltbld', 17:10:46 INFO - 'MAIL': '/var/mail/cltbld', 17:10:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:10:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:46 INFO - 'MOZ_NO_REMOTE': '1', 17:10:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:46 INFO - 'NO_EM_RESTART': '1', 17:10:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:46 INFO - 'PWD': '/builds/slave/test', 17:10:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:10:46 INFO - 'SHELL': '/bin/bash', 17:10:46 INFO - 'SHLVL': '1', 17:10:46 INFO - 'TERM': 'linux', 17:10:46 INFO - 'TMOUT': '86400', 17:10:46 INFO - 'USER': 'cltbld', 17:10:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303', 17:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:46 INFO - '_': '/tools/buildbot/bin/python'} 17:10:46 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/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 17:10:46 INFO - mozversion application_buildid: 20160229162331 17:10:46 INFO - mozversion application_changeset: 1a61474707944169a43fddb94b3cf6da565df8dd 17:10:46 INFO - mozversion application_display_name: Nightly 17:10:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:10:46 INFO - mozversion application_name: Firefox 17:10:46 INFO - mozversion application_remotingname: firefox 17:10:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:10:46 INFO - mozversion application_vendor: Mozilla 17:10:46 INFO - mozversion application_version: 47.0a1 17:10:46 INFO - mozversion platform_buildid: 20160229162331 17:10:46 INFO - mozversion platform_changeset: 1a61474707944169a43fddb94b3cf6da565df8dd 17:10:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:10:46 INFO - mozversion platform_version: 47.0a1 17:10:46 INFO - using testdate: 1456794646 17:10:46 INFO - actual date: 1456794646 17:10:46 INFO - starting webserver on 'localhost:33539' 17:10:46 INFO - SUITE-START | Running 2 tests 17:10:46 INFO - TEST-START | dromaeo_css 17:10:46 INFO - operating with platform_type : linux_ 17:10:46 INFO - Initialising browser for dromaeo_css test... 17:10:46 INFO - TEST-INFO | started process 11728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE0N14y/profile http://localhost:33539/getInfo.html) 17:10:50 INFO - PROCESS | 11728 | 17:10:50 INFO - PROCESS | 11728 | (process:11810): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:10:51 INFO - PROCESS | 11728 | __metrics Screen width/height:1600/1200 17:10:51 INFO - PROCESS | 11728 | colorDepth:24 17:10:51 INFO - PROCESS | 11728 | Browser inner width/height: 1024/697 17:10:51 INFO - PROCESS | 11728 | __metrics 17:10:52 ERROR - PROCESS | 11728 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:10:52 INFO - PROCESS | 11728 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:10:52 INFO - PROCESS | 11728 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:10:52 INFO - PROCESS | 11728 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:10:52 INFO - PROCESS | 11728 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:10:52 INFO - PROCESS | 11728 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:10:52 INFO - PROCESS | 11728 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:10:52 INFO - PROCESS | 11728 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:10:52 INFO - PROCESS | 11728 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:10:52 INFO - PROCESS | 11728 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:10:53 INFO - TEST-INFO | 11728: exit 0 17:10:53 INFO - Browser initialized. 17:10:53 INFO - Running cycle 1/1 for dromaeo_css test... 17:10:53 INFO - TEST-INFO | started process 11861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE0N14y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:54 INFO - PROCESS | 11861 | 17:10:54 INFO - PROCESS | 11861 | (process:11916): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:11:05 INFO - PROCESS | 11861 | RSS: Main: 161361920 17:11:05 INFO - PROCESS | 11861 | 17:11:54 INFO - PROCESS | 11861 | 1456794714710 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] 17:14:06 INFO - PROCESS | 11861 | Cycle 1(1): loaded http://localhost:33539/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33539/tests/dromaeo/cssquery-ext.html) 17:14:07 INFO - PROCESS | 11861 | RSS: Main: 167583744 17:14:07 INFO - PROCESS | 11861 | 17:17:09 INFO - PROCESS | 11861 | Cycle 1(1): loaded http://localhost:33539/tests/dromaeo/cssquery-ext.html (next: http://localhost:33539/tests/dromaeo/cssquery-jquery.html) 17:17:10 INFO - PROCESS | 11861 | RSS: Main: 164347904 17:17:10 INFO - PROCESS | 11861 | 17:20:11 INFO - PROCESS | 11861 | Cycle 1(1): loaded http://localhost:33539/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33539/tests/dromaeo/cssquery-mootools.html) 17:20:12 INFO - PROCESS | 11861 | RSS: Main: 166211584 17:20:12 INFO - PROCESS | 11861 | 17:23:14 INFO - PROCESS | 11861 | Cycle 1(1): loaded http://localhost:33539/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33539/tests/dromaeo/cssquery-prototype.html) 17:23:14 INFO - PROCESS | 11861 | RSS: Main: 164466688 17:23:14 INFO - PROCESS | 11861 | 17:26:17 INFO - PROCESS | 11861 | Cycle 1(1): loaded http://localhost:33539/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33539/tests/dromaeo/cssquery-yui.html) 17:26:18 INFO - PROCESS | 11861 | RSS: Main: 164126720 17:26:18 INFO - PROCESS | 11861 | 17:29:20 INFO - PROCESS | 11861 | Cycle 1(1): loaded http://localhost:33539/tests/dromaeo/cssquery-yui.html (next: http://localhost:33539/tests/dromaeo/cssquery-dojo.html) 17:29:20 INFO - PROCESS | 11861 | RSS: Main: 168427520 17:29:20 INFO - PROCESS | 11861 | 17:29:20 INFO - PROCESS | 11861 | __start_tp_report 17:29:20 INFO - PROCESS | 11861 | _x_x_mozilla_page_load 17:29:20 INFO - PROCESS | 11861 | _x_x_mozilla_page_load_details 17:29:20 INFO - PROCESS | 11861 | |i|pagename|runs| 17:29:20 INFO - PROCESS | 11861 | |0;dojo.html;2654.3629528913066;2662.6937902141253;2677.397585543252;2689.905853295134;2697.986510067449;4593.0354625528635;4593.471750748665;4613.653975951808;4618.653600979927;4673.906521869565;4662.5803677669;4683.203855344591;4690.624750019999;4691.648126390517;4716.669833111683;4291.399204111427;4315.848945286915;4334.566543345664;4428.468583769952;4477.955220447787;4118.567550407209;4225.42956700846;4392.516823149467;4426.62373698236;4440;4308.719933204347;4310.956890431118;4340.739555626673;4355.586219309161;4381.16757816014;4295.3771703102875;4344.087741574273;4344.522102568715;4360.280553708634;4380.123975204971;4107.63031327179;4257.74453532789;4290.927268182954;4307.483102027777;4397.010672598672;4575.702579332333;4596.03483268514;4610.9308360374625;4639.048994956026;4674.555917187861;4955.40535135786;5005.674631148963;5006.74966251686;5020.221865610836;5052.444231134572;4815.3258543803895;5012.72430016349;5051.090803655341;5123;5137.152369858969;4624.445066591963;4650.906981860344;4654.25531914892;4659.277811939155;4696.319033740088;5114.8977020460125;5116.309298244763;5119.436861945183;5121.718305493159;5172.793088276502;4807.110684523374;4869.70781753096;4914.533119353656;4926.310316555685;4957.157283261854;4843.782029808667;5001.24981252815;5023.6483446159145;5032.295478632995;5121.539061484485;4973.42805577356;4999.375078115236;5005.424376196784;5021.447640759514;5070.949290507121;4780.832670856504;4911.45973942866;4951.455339912607;4966.379202599675;4979.979104283613;4171.83312667496;4187.685923555685;4197;4199.68502362324;4240.448741663564;3573.10672331917;3684.7420680552104;3709.629037096269;3710.350688629479;3727.086863718406;4331.220380331571;4348.43470348859;4357.997660538031;4368.650507959355;4407.27279998803;4980.228064649985;5015.04714104319;5024.723640199751;5034.395872495324;5044.066847633127;4220.53574106848;4312.288472402019;4362.6946113772365;4364.934525982113;4368.716033457815;4488.035072459437;4491.910161796745;4502.774861256924;4531.13908357411;4534.88662783433;4774.188387974053;4777.187878060738;4787.61699064081;4802.759862006886;4809.254565542346;4853.951460485491;4948.084604348207;5026.52248036436;5080.517350851663;5081.644284900021;4773.952260477351;4783.258594917794;4799.1601469743355;4801.95198048015;4845.6608037437045;5001.399832020181;5002.274670172877;5012.573931215888;5015.749212539431;5032.194848824171;4892.412910450768;5025.346704928336;5047.394312682502;5084.466131056186;5126.53861152498;4870.95129048705;4884.755762211804;4892.290617860319;4911.459739428731;4925.335079764186;4879.243717223836;4889.291052797395;4892.119418504703;4905.754712264301;4925.802967881388;4587.128445595326;4716.103940251342;4739.526047395233;4779.354787103835;4831.468538460696;4871.2206047032305;4877.756112194305;4884.65807393479;4887.486813884633;4919.163742163769;4751.382320298339;4771.856844294677;4785.545373189541;4797.208460603962;4800.855974320776 17:29:20 INFO - PROCESS | 11861 | |1;ext.html;501.8143286983814;514.7066172281799;529.8860744939838;544.4093158922569;550.4962958892613;34998.82500587497;35610.82194589027;35763.4635480468;35767;35900;36721.08197295069;37038.814805926;37456.438153427654;37498.62501374986;37524;7549.7735067947915;7837.529748215125;7840.098388685288;7868.4098692598;7875.645595948167;7544.509606875563;7679.116901556309;7696.037995250594;7705.845883082335;7718.961405192967;7668.4248681348845;7683.500572462772;7700.614969251543;7705.383569314469;7727.768166955;7638.618069096523;7682.961585192038;7725.575093369891;7734.613269336511;7761.068671759369;7618.8095297618;7681.3854891608535;7690.192529784404;7712.460127791057;7728.072631284225;33195.834020829985;33567.16082097943;33653;33664.32671346559;33687.66312336894;1858.4238885945401;2586.405126820842;2699.5140874642557;2736.7126451722484;2741.8080734348605;24815.25554233358;27121.321966950785;28157.155285341472;28375.57436638452;28512.85948562055;3080.1067690369764;3082.2631030892094;3123.422166899131;3125.4217969675683;3161.683831616843;218673;220420;220424.8978755112;221223;221585;52649.473505265225;52715;52965.20552191643;53080.469195308324;53214.20178697323;56407.15389269164;58471;60578;60610.39389606047;60792.696036519534;12313.26120432777;12450.75098498043;12485.375731213402;12520.186187897758;12554.686132846751;8564.914350856536;8612;8616.827663446697;8620;8630.956845215735;18347.816521834877;18408.539786505444;18444.538886527946;18503.53741156455;18585.721214181798;7749.108852482037;7995.880061799077;8039.47743396689;8091.271785539329;8149.592520373958;807.2169995104739;899.3434792601438;943.6649989253854;1013.2198207380276;1029.4543891737392;25644.487110258062;26078.739212608012;26190.476190476085;26208.34479138037;26888.59667104995;914.4558987402485;987.0820137272406;1024.8565200871883;1047.471027131309;1051.994740026295;13652.112612680145;13843.86156138446;13943.372548235353;14015.579532614038;14279.286035698173;260609;262587;264035;266078;266272;45597.31604025942;46013.76993115013;46067.76966115148;46082.30876536854;46121.769391152826;1149.7528031473273;1197.5569039455283;1222.2971791220084;1226.632304979941;1226.7546490701895;24581.262562123164;25486.362840929127;25489.872550637127;25753.484930301664;25781.87109064443;39562.80218598888;39623.60376396199;39629.80185099056;39694.80152599334;39860.601393985686;209473;209480;210338;211142;211327;29344.11967640974;29788.255293617833;29843.552346714383;38856.41715374215;39766;34584.13539661428;34703;34733;35185.296294074484;35191.824040879634;32376.676233238308;32435;33253.66746332506;33303.83348083244;33417.66582334146;32584.83707581447;32627.34745305128;33022.83488582542;33248.66751332456;33754.493682595275;32909.17727056843;32964.50553241655;33107.834460827544;33368.49947250842;33746.32507349888;29120;31174.532382014742;31440.213994650316;32751.34497310088;32774;22537.887310563343;22900.656490152327;22980.655290170325;23488.64767028462;24197.274081777574 17:29:20 INFO - PROCESS | 11861 | |2;jquery.html;339.9507071474636;340.1733786897837;344.392147859029;345.39383382164306;347.4961306106145;15290.847091529082;15650.217489125542;16262.756058659115;16279.755803662925;16315.673686526263;14893.627659308522;15191.46829860955;15277.6944461111;15506.302216400261;15555.766663500028;4884.633652476061;5120.950205207923;5124.282600435942;5143.81996630118;5157.149070403379;6014.909776353358;6299.464545513637;6304.085907543404;6309.116723658692;6325.240971083476;6091.14723938649;6259.403852017729;6635.701393437307;6661.700223489955;6672.59964402135;6525.510586705992;6549.083128362057;6559.573627714207;6583.736650533973;6584.473242140617;5883.911741323884;6156.722947467375;6161.938380616226;6162.1681073055015;6163.322034576193;18802.81197188038;20814.687779683318;21337.253196138216;21715.34853954368;21848.453788655253;1790.149678902511;1892.1863598652574;2004.7594288685304;2162.740471143473;2683.409649877024;12866.099373043891;13372.799408008888;13382.799258011137;13446.596602101952;13662.18026918388;1856.786469556005;1864.5245462407136;1903.2196799312217;1919.9712004319947;1926.4509614759866;45198.54801452009;51600.48399515994;51874.48125518772;53682.19476707852;53777.19334209951;14567.198804065878;15029;15249.313780879887;15301.693966120616;15825.52523424299;22925.541489170457;23211.419714507272;23224.3032709019;23234.767652323597;23293.767062329498;7187.173475050332;7342.339189472973;7385.261473852679;7545.773626791205;7574.015378000825;6022.337542870281;6044.818655440344;6134.693265336716;6224.751009959641;6315.747370105236;7687;7762.068551773823;7812.492188007761;7814.452988290879;7882.763517094496;3189.1070500259966;3246.318273162662;3265.9020229393154;3281.8194999274792;3375.628680845105;385.7723942873718;392.6583872031351;411.7488332117406;411.94232807406985;779.9571023593643;8954.641814327353;9471;9665.516724163763;9687.806243875224;9786.461744603972;410.5627506705349;430.54362375881664;432.0775145065308;437.90803931174173;444.25143632978535;5416.458354164552;5443.292371991616;5473.233747275384;5546.528545073633;5570.860728481739;367599;367852;368186;371115;375606;66118.33881661217;66150.66924665346;66487.66756166285;67974.66012669905;68811.65594172098;373.16038912446993;412.34643090701576;426.4009067260442;426.90181258310764;429.05179553187804;9506.857397139187;9535.618575256913;9599.616015359308;9610.327277090537;9659.517024148905;27977.72022279751;28686;28914.710852892043;29029.709702903547;29897.252568685086;37235;40393.39409908795;42900.35649465323;43524.56475435205;44251.778741106085;6407.71165297572;6499.122618446449;6687.130673012477;6698.062271282122;6716.429103526255;9553.47455889905;9561.187299079656;9691;9959.850602240827;10090.596376144871;8432.988041435066;8529.317654587494;8543.786405339917;8763.298936085226;8995.640174393213;6871.03805467245;8885.200331969894;8893.555322233991;9328.860067099135;9620.172167288192;9081.636734530544;9218.170364667212;9262.16640502358;9666.371685840399;9725.610975560898;6927.965360173167;7052.506324557232;7093.787186384417;7188.065551478275;7207.243239459991;7072;8796.692115775917;9302.860457093284;9528.380655257386;9565.665201717906 17:29:20 INFO - PROCESS | 11861 | |3;mootools.html;1347.5755137131803;1370.5614203454893;1485.9331330090145;1702.361614394602;1718.1752758675834;5967.4927631151295;6939.618320992344;7070.116235470567;7299.416046716263;7304.086989126353;7128.5366451180635;7148.213696493382;7172.31862973018;7222.133343998715;7222.494425390225;2085.16593362655;2111.3876975677035;2112.207922029239;2121.469632591852;2122.5118222808765;2063.4531849060013;2065.2874758208395;2066.0599427260636;2102.127617038927;2105.9684104738367;2049.9897500512475;2089.9791002089937;2102.547952190279;2109.8101170894615;2119.3324102907613;2075.522629795148;2079.199508189343;2083.9791602084088;2084.9791502085013;2085.7914208579173;2065.659166237569;2085.405659387083;2097.2974053692033;2107.4415279950827;2109.325015994882;7310.195878453366;7317.524360916524;7389.371903388218;7397.075365579302;7404.629768511553;4277.572242775728;4342.891427714301;4361.542038086019;4383.079553293812;4390.956090439086;2678.9598156027673;2720.8503532305717;2768.197222805384;2792.2321361625513;2806.789490788199;853.8292341531718;1610.8630766384754;1626.1137679964447;1642.2691902103568;1657.2625181794106;9469.431834089908;9498.810023799555;9508.85736713943;9530.189933855561;9538.904610953941;3758.2107757370713;3882.825272862728;3890.8249128788707;3918.8432462701744;3920.941185882214;7692.076950765944;7714.498557593738;7721.498102623312;7732.188120247293;7754.6898124074405;4236.3857240700545;4253.319468885025;4258.063226090255;4280.186764514795;4282.464691913511;3171.1120886151916;3775.5091838060875;3844.1735026968777;3850.614938506127;3873.7288389812443;3149.5590617313596;3178.9682103179134;3204.8878289259765;3218.5011323244466;3225.822579758136;945.9337846350827;973.2408721197477;973.3089506450358;978.0854900667898;988.8961659025842;864.9394542381973;892.3753372639178;1162.3490845126755;1163.0288708927972;1189.9881001190051;6719.260881303053;6726.293739157416;6745.190577130776;6748.763793267212;6816.216135144423;1047.7171163785736;1066.632011955874;1072.7639919217759;1090.4493230918335;1093.1965005720788;5321.467853214725;5350.38470575881;5367.463253674601;5398.325209348832;5399.163129714901;8537.957310213409;8984.595693193822;8987.281017518582;9013.819723605622;9029.187373136449;8777.561121943878;8813.647454101892;8841;8882.911170888337;8933.865992010125;6764.898526522106;6959.338862808025;6979.4416446684145;6996.090508233999;7014.719411223494;6664.533482656361;6666.799996000128;6667.066610674412;6685.09751183584;6687.09724187248;7809.492382995087;7906.881396778937;7941.047074351115;7998.760037198894;7999.040115186215;7497.925020749941;7782.961085194538;7795.649195786316;7847.254510821463;7883.408744344082;5123.897522049613;6030;6099;6130.386961304012;6271.560990730605;6834.419074378733;6847.281035491202;6848.760293389708;6882.896756548756;6884.65576721152;5846.707664616837;5969.940300596939;6008.279006519246;6022.759089636365;6022.819315420545;5930.584859059824;5933.940660593339;6022.789202377896;6043.244594425697;6044.607100538451;6209.285932117684;6244.500439964701;6366.554341196072;6437.678116094083;6444.065610486359;5942;5973.731182096729;5988.6706231157705;6026.276846778414;6035.668038257938;5922.615030023035;6069.51443884497;6074.36219196978;6090.878182436415;6099.9390006099375 17:29:20 INFO - PROCESS | 11861 | |4;prototype.html;289.8376908930999;298.18892612095095;302.8909592546683;303.5477139062797;308.46019465934614;5674.375818659944;5741.138829175626;5751.65490070596;5762.193292938987;5785.971070144644;5647.661140331583;5659.745311460983;5660.801871934483;5665.886682266362;5679.886402271952;4018.8392464301464;4185.351270553069;4281.314989601664;4281.785910704468;4295.140971805636;4257.701960862741;4308.719933204347;4347.630451411634;4350.238708226064;4355.912881742363;4283.892902677442;4286.357046443043;4299.3550967354995;4305.354196870463;4311.892202694927;4289.764062976535;4294.935575966363;4295.205387003399;4303.634191093745;4317.0934103838235;3761.285355782393;3769.754965927206;3770.9245815083545;3776.3957766757185;3782.3569993100964;5442.319710036246;5446.319210098738;5450.863728406782;5464.644798088151;5467.043267428184;4706.5293470653005;4841.70949743013;4901.411830580318;4922.680025798311;5025.447200807908;5931.258592675916;5936.22829032223;5950.077737950624;5950.285965684102;5956.315023772235;3982.8008599570194;3987.6809855211513;3990.06233535119;3990.2618015666903;3993.7204395692315;6200.069989501566;6232.8130156095385;6263.31103578606;6268.905966410507;6270.905936410957;4097.221527909687;4099.959000410017;4100.077482566398;4100.36444351126;4107.301758701028;4160.646345060703;4162.5629308922125;4164.541900390955;4166.687498437629;4168.603982621707;4639.8144074237325;4804.975975120172;4813.831515896927;4819.6867203631655;4819.879503012453;5886.411358864165;5963.642181469126;5966.433188847052;5972.074328479092;5989.610675306091;1444.6316189371644;1466.6773309871812;1471.0879254862054;1471.977920331196;1473.9336729847182;949.710338346797;959.7216807125856;972.8881178664402;976.1019861727228;977.452626529146;5169.276301317818;5180.689158650418;5183.170692689227;5190.455002224788;5192.4807519248525;6126.663033533109;6153.784617538365;6185.536084793568;6192.380761923771;6202.131701561785;5049.394072711299;5153.1497302945345;5162.174052151638;5210.687358758487;5260.210968354778;3352.597688277422;3387;3387.1024178592693;3389.305192435545;3391.847366868497;5812.244408226903;5863.413658634103;5874.676892770854;5879.882402352015;5884.911726324109;6427.453666438405;6446.645434501147;6451.9354806452275;6452.870942581122;6458.580192287486;5853.268341457318;5862.794802181903;5866.941330586725;5868;5890.322612899486;6053.424924632153;6159.353267906985;6248.062790581449;6259.467945224706;6265.8120256392385;6125.816225513242;6142.600730952474;6149.139120523041;6158.076288556752;6158.32258451561;5853.297604287342;5859.5019423349495;5885.058390657646;5885.735141918538;5887.264091988502;4074.4703188585295;4113.424120623175;4115.54728979818;4116.259073366823;4120.011197312683;6199.16311297969;6233.844153896189;6235.844103897439;6269.96865015672;6278.8430289241305;5792.189093526826;6001.549883758648;6019.307779605227;6031.5777895548645;6033.9698301508215;6014.6391216527145;6022.668753218615;6027.246594175728;6055.182550355646;6067.362926892612;5874.853128671817;5878.088896221093;5883.117532370179;5898.469137777621;5902.468777810018;6050.485708714808;6058.0610005449225;6060.515158787198;6084.300305464928;6087.965045942112;5711.914321285101;5905.527557795452;5921.733521991435;5923.674197918984;5931.08068249422 17:29:20 INFO - PROCESS | 11861 | |5;yui.html;642.3415998601433;654.1463390275694;665.1187176990486;686.4611280145087;691.7924622613216;9839.901600983989;9911.851322230154;9940.751481212974;9944.850827237578;10598.576056957721;11379.886201137986;12716.427760750765;12894.93552532236;12931.935340323285;12968.481260749559;700.58315302395;772.3087836386417;778.2101167315179;784.5410434895593;786.1077676836775;771.9382449404034;774.5623722596742;774.8721460958935;775.7944144801633;778.6534991928594;804.3645520039162;813.2639960835453;813.422470046265;816.244973399606;817.9550124743137;797.4856217739525;802.9437939344219;805.5851236613149;806.770070529902;807.4670717326536;601.4316470934968;601.5909181756404;602.3705228036712;603.3182503770755;604.3714536881638;10918.399488028155;10948.726281842937;10982.670519884416;11016.614418495314;11057.834132488018;10817;11071.889281107166;11127.165462590257;11217.270877393024;11264.21150519464;9043.59303831329;9158.542072896329;9249.936257330426;9250.583723732449;9261.536923153883;2999.6700362960273;3172.38138562978;3212.405704944593;3226.8547915343865;3257.690519400653;40981.385279220834;41902.1619567607;42014.36978445326;42035.1592968142;42147.578524214674;8845.601947912359;8913.955430222937;9034.096590340914;9090;9140.954295228614;15804.525864224091;15806;15820.60448488797;15836.129012904401;15999.920000399923;6231.376862313732;6297.842553936188;6616.8345791355605;6732.932670673328;6782.694778734969;3611.602723700443;3656.213914008501;3669.9266014679556;3713.220223752988;3734.477173195755;2470.0984140788482;2483.726790053093;2495.1017633651873;2503.561876671575;2504.9373765656005;442.14665695208555;444.76649758876204;447.2843450479272;459.75862672096747;461.4462644826155;527.5911168844176;577.9508741756914;587.0121083684069;593.3443544882842;596.3887015808831;6855.108835851307;6982.2879808099215;7236.00715506299;7520.247975202436;7666.271704188093;517.5083670513028;544.9700266485302;545.7871430142247;545.8198794397919;573.3864764701813;3220.8101667990563;3266.852991615383;3274.836258187129;3325.3515564465183;3638.21778317663;47902.28146577804;48429.75785121052;48496.5150348492;48606;48774.26838597424;43123.568764312586;43531.78234108809;43992;44077.55922440799;44127.33808992868;38724.80637596794;39506.20987580232;39585;39613.80193099016;39749.80125099414;6369.90445143314;6402.35976402356;6501.544891857525;6586.901196482152;6856.588604683735;30516.847415763667;30717;31071;31586;31720.206994825316;36148.81925590355;36962.81518592498;38170;38642.80678596589;38670.22659546737;8355.080941096596;8481.745547633582;8659.090795466385;8679.566021699016;8702.956485217534;9169.679061232824;9398.624055037995;9444.763880903032;11216.327020378803;11289.266197697123;9320.95339523298;9553.474558899326;9968.451735154636;10266.178705703376;10823.783524329627;9693.176080033276;9832.901670983485;9853.556589953612;9927.453990030617;10146.847797282899;7948.682052717826;9004.189622933967;9130.680426185052;10000.899991000288;10107.595696172071;8687.782805429662;9008.901308547118;9029.593668284811;9075.591598378222;9156.130167634064;8697.91302086971;8757.91242087571;8777.166169213915;9132.543372831466;9261.351705380559 17:29:20 INFO - PROCESS | 11861 | __end_tp_report 17:29:20 INFO - PROCESS | 11861 | __start_cc_report 17:29:20 INFO - PROCESS | 11861 | _x_x_mozilla_cycle_collect,337 17:29:20 INFO - PROCESS | 11861 | __end_cc_report 17:29:20 INFO - PROCESS | 11861 | __startTimestamp1456795760628__endTimestamp 17:29:20 INFO - PROCESS | 11861 | 17:29:20 INFO - PROCESS | 11861 | ------- Summary: start ------- 17:29:20 INFO - PROCESS | 11861 | Number of tests: 6 17:29:20 INFO - PROCESS | 11861 | 17:29:20 INFO - PROCESS | 11861 | [#0] dojo.html Cycles:165 Average:4631.35 Median:4777.19 stddev:479.06 (10.0%) stddev-sans-first:454.73 17:29:20 INFO - PROCESS | 11861 | Values: 2654.4 2662.7 2677.4 2689.9 2698.0 4593.0 4593.5 4613.7 4618.7 4673.9 4662.6 4683.2 4690.6 4691.6 4716.7 4291.4 4315.8 4334.6 4428.5 4478.0 4118.6 4225.4 4392.5 4426.6 4440.0 4308.7 4311.0 4340.7 4355.6 4381.2 4295.4 4344.1 4344.5 4360.3 4380.1 4107.6 4257.7 4290.9 4307.5 4397.0 4575.7 4596.0 4610.9 4639.0 4674.6 4955.4 5005.7 5006.7 5020.2 5052.4 4815.3 5012.7 5051.1 5123.0 5137.2 4624.4 4650.9 4654.3 4659.3 4696.3 5114.9 5116.3 5119.4 5121.7 5172.8 4807.1 4869.7 4914.5 4926.3 4957.2 4843.8 5001.2 5023.6 5032.3 5121.5 4973.4 4999.4 5005.4 5021.4 5070.9 4780.8 4911.5 4951.5 4966.4 4980.0 4171.8 4187.7 4197.0 4199.7 4240.4 3573.1 3684.7 3709.6 3710.4 3727.1 4331.2 4348.4 4358.0 4368.7 4407.3 4980.2 5015.0 5024.7 5034.4 5044.1 4220.5 4312.3 4362.7 4364.9 4368.7 4488.0 4491.9 4502.8 4531.1 4534.9 4774.2 4777.2 4787.6 4802.8 4809.3 4854.0 4948.1 5026.5 5080.5 5081.6 4774.0 4783.3 4799.2 4802.0 4845.7 5001.4 5002.3 5012.6 5015.7 5032.2 4892.4 5025.3 5047.4 5084.5 5126.5 4871.0 4884.8 4892.3 4911.5 4925.3 4879.2 4889.3 4892.1 4905.8 4925.8 4587.1 4716.1 4739.5 4779.4 4831.5 4871.2 4877.8 4884.7 4887.5 4919.2 4751.4 4771.9 4785.5 4797.2 4800.9 17:29:20 INFO - PROCESS | 11861 | 17:29:20 INFO - PROCESS | 11861 | [#1] ext.html Cycles:180 Average:39159.96 Median:33393.08 stddev:60609.15 (181.5%) stddev-sans-first:60709.67 17:29:20 INFO - PROCESS | 11861 | Values: 501.8 514.7 529.9 544.4 550.5 34998.8 35610.8 35763.5 35767.0 35900.0 36721.1 37038.8 37456.4 37498.6 37524.0 7549.8 7837.5 7840.1 7868.4 7875.6 7544.5 7679.1 7696.0 7705.8 7719.0 7668.4 7683.5 7700.6 7705.4 7727.8 7638.6 7683.0 7725.6 7734.6 7761.1 7618.8 7681.4 7690.2 7712.5 7728.1 33195.8 33567.2 33653.0 33664.3 33687.7 1858.4 2586.4 2699.5 2736.7 2741.8 24815.3 27121.3 28157.2 28375.6 28512.9 3080.1 3082.3 3123.4 3125.4 3161.7 218673.0 220420.0 220424.9 221223.0 221585.0 52649.5 52715.0 52965.2 53080.5 53214.2 56407.2 58471.0 60578.0 60610.4 60792.7 12313.3 12450.8 12485.4 12520.2 12554.7 8564.9 8612.0 8616.8 8620.0 8631.0 18347.8 18408.5 18444.5 18503.5 18585.7 7749.1 7995.9 8039.5 8091.3 8149.6 807.2 899.3 943.7 1013.2 1029.5 25644.5 26078.7 26190.5 26208.3 26888.6 914.5 987.1 1024.9 1047.5 1052.0 13652.1 13843.9 13943.4 14015.6 14279.3 260609.0 262587.0 264035.0 266078.0 266272.0 45597.3 46013.8 46067.8 46082.3 46121.8 1149.8 1197.6 1222.3 1226.6 1226.8 24581.3 25486.4 25489.9 25753.5 25781.9 39562.8 39623.6 39629.8 39694.8 39860.6 209473.0 209480.0 210338.0 211142.0 211327.0 29344.1 29788.3 29843.6 38856.4 39766.0 34584.1 34703.0 34733.0 35185.3 35191.8 32376.7 32435.0 33253.7 33303.8 33417.7 32584.8 32627.3 33022.8 33248.7 33754.5 32909.2 32964.5 33107.8 33368.5 33746.3 29120.0 31174.5 31440.2 32751.3 32774.0 22537.9 22900.7 22980.7 23488.6 24197.3 17:29:20 INFO - PROCESS | 11861 | 17:29:20 INFO - PROCESS | 11861 | [#2] jquery.html Cycles:180 Average:22423.79 Median:5429.88 stddev:60614.16 (1116.3%) stddev-sans-first:60761.52 17:29:20 INFO - PROCESS | 11861 | Values: 340.0 340.2 344.4 345.4 347.5 15290.8 15650.2 16262.8 16279.8 16315.7 14893.6 15191.5 15277.7 15506.3 15555.8 4884.6 5121.0 5124.3 5143.8 5157.1 6014.9 6299.5 6304.1 6309.1 6325.2 6091.1 6259.4 6635.7 6661.7 6672.6 6525.5 6549.1 6559.6 6583.7 6584.5 5883.9 6156.7 6161.9 6162.2 6163.3 18802.8 20814.7 21337.3 21715.3 21848.5 1790.1 1892.2 2004.8 2162.7 2683.4 12866.1 13372.8 13382.8 13446.6 13662.2 1856.8 1864.5 1903.2 1920.0 1926.5 45198.5 51600.5 51874.5 53682.2 53777.2 14567.2 15029.0 15249.3 15301.7 15825.5 22925.5 23211.4 23224.3 23234.8 23293.8 7187.2 7342.3 7385.3 7545.8 7574.0 6022.3 6044.8 6134.7 6224.8 6315.7 7687.0 7762.1 7812.5 7814.5 7882.8 3189.1 3246.3 3265.9 3281.8 3375.6 385.8 392.7 411.7 411.9 780.0 8954.6 9471.0 9665.5 9687.8 9786.5 410.6 430.5 432.1 437.9 444.3 5416.5 5443.3 5473.2 5546.5 5570.9 367599.0 367852.0 368186.0 371115.0 375606.0 66118.3 66150.7 66487.7 67974.7 68811.7 373.2 412.3 426.4 426.9 429.1 9506.9 9535.6 9599.6 9610.3 9659.5 27977.7 28686.0 28914.7 29029.7 29897.3 37235.0 40393.4 42900.4 43524.6 44251.8 6407.7 6499.1 6687.1 6698.1 6716.4 9553.5 9561.2 9691.0 9959.9 10090.6 8433.0 8529.3 8543.8 8763.3 8995.6 6871.0 8885.2 8893.6 9328.9 9620.2 9081.6 9218.2 9262.2 9666.4 9725.6 6928.0 7052.5 7093.8 7188.1 7207.2 7072.0 8796.7 9302.9 9528.4 9565.7 17:29:20 INFO - PROCESS | 11861 | 17:29:20 INFO - PROCESS | 11861 | [#3] mootools.html Cycles:180 Average:4992.43 Median:6024.55 stddev:2561.72 (42.5%) stddev-sans-first:2554.26 17:29:20 INFO - PROCESS | 11861 | Values: 1347.6 1370.6 1485.9 1702.4 1718.2 5967.5 6939.6 7070.1 7299.4 7304.1 7128.5 7148.2 7172.3 7222.1 7222.5 2085.2 2111.4 2112.2 2121.5 2122.5 2063.5 2065.3 2066.1 2102.1 2106.0 2050.0 2090.0 2102.5 2109.8 2119.3 2075.5 2079.2 2084.0 2085.0 2085.8 2065.7 2085.4 2097.3 2107.4 2109.3 7310.2 7317.5 7389.4 7397.1 7404.6 4277.6 4342.9 4361.5 4383.1 4391.0 2679.0 2720.9 2768.2 2792.2 2806.8 853.8 1610.9 1626.1 1642.3 1657.3 9469.4 9498.8 9508.9 9530.2 9538.9 3758.2 3882.8 3890.8 3918.8 3920.9 7692.1 7714.5 7721.5 7732.2 7754.7 4236.4 4253.3 4258.1 4280.2 4282.5 3171.1 3775.5 3844.2 3850.6 3873.7 3149.6 3179.0 3204.9 3218.5 3225.8 945.9 973.2 973.3 978.1 988.9 864.9 892.4 1162.3 1163.0 1190.0 6719.3 6726.3 6745.2 6748.8 6816.2 1047.7 1066.6 1072.8 1090.4 1093.2 5321.5 5350.4 5367.5 5398.3 5399.2 8538.0 8984.6 8987.3 9013.8 9029.2 8777.6 8813.6 8841.0 8882.9 8933.9 6764.9 6959.3 6979.4 6996.1 7014.7 6664.5 6666.8 6667.1 6685.1 6687.1 7809.5 7906.9 7941.0 7998.8 7999.0 7497.9 7783.0 7795.6 7847.3 7883.4 5123.9 6030.0 6099.0 6130.4 6271.6 6834.4 6847.3 6848.8 6882.9 6884.7 5846.7 5969.9 6008.3 6022.8 6022.8 5930.6 5933.9 6022.8 6043.2 6044.6 6209.3 6244.5 6366.6 6437.7 6444.1 5942.0 5973.7 5988.7 6026.3 6035.7 5922.6 6069.5 6074.4 6090.9 6099.9 17:29:20 INFO - PROCESS | 11861 | 17:29:20 INFO - PROCESS | 11861 | [#4] prototype.html Cycles:180 Average:4918.36 Median:5695.90 stddev:1491.27 (26.2%) stddev-sans-first:1454.43 17:29:20 INFO - PROCESS | 11861 | Values: 289.8 298.2 302.9 303.5 308.5 5674.4 5741.1 5751.7 5762.2 5786.0 5647.7 5659.7 5660.8 5665.9 5679.9 4018.8 4185.4 4281.3 4281.8 4295.1 4257.7 4308.7 4347.6 4350.2 4355.9 4283.9 4286.4 4299.4 4305.4 4311.9 4289.8 4294.9 4295.2 4303.6 4317.1 3761.3 3769.8 3770.9 3776.4 3782.4 5442.3 5446.3 5450.9 5464.6 5467.0 4706.5 4841.7 4901.4 4922.7 5025.4 5931.3 5936.2 5950.1 5950.3 5956.3 3982.8 3987.7 3990.1 3990.3 3993.7 6200.1 6232.8 6263.3 6268.9 6270.9 4097.2 4100.0 4100.1 4100.4 4107.3 4160.6 4162.6 4164.5 4166.7 4168.6 4639.8 4805.0 4813.8 4819.7 4819.9 5886.4 5963.6 5966.4 5972.1 5989.6 1444.6 1466.7 1471.1 1472.0 1473.9 949.7 959.7 972.9 976.1 977.5 5169.3 5180.7 5183.2 5190.5 5192.5 6126.7 6153.8 6185.5 6192.4 6202.1 5049.4 5153.1 5162.2 5210.7 5260.2 3352.6 3387.0 3387.1 3389.3 3391.8 5812.2 5863.4 5874.7 5879.9 5884.9 6427.5 6446.6 6451.9 6452.9 6458.6 5853.3 5862.8 5866.9 5868.0 5890.3 6053.4 6159.4 6248.1 6259.5 6265.8 6125.8 6142.6 6149.1 6158.1 6158.3 5853.3 5859.5 5885.1 5885.7 5887.3 4074.5 4113.4 4115.5 4116.3 4120.0 6199.2 6233.8 6235.8 6270.0 6278.8 5792.2 6001.5 6019.3 6031.6 6034.0 6014.6 6022.7 6027.2 6055.2 6067.4 5874.9 5878.1 5883.1 5898.5 5902.5 6050.5 6058.1 6060.5 6084.3 6088.0 5711.9 5905.5 5921.7 5923.7 5931.1 17:29:20 INFO - PROCESS | 11861 | 17:29:20 INFO - PROCESS | 11861 | [#5] yui.html Cycles:180 Average:11827.62 Median:590.18 stddev:13627.12 (2309.0%) stddev-sans-first:13639.46 17:29:20 INFO - PROCESS | 11861 | Values: 642.3 654.1 665.1 686.5 691.8 9839.9 9911.9 9940.8 9944.9 10598.6 11379.9 12716.4 12894.9 12931.9 12968.5 700.6 772.3 778.2 784.5 786.1 771.9 774.6 774.9 775.8 778.7 804.4 813.3 813.4 816.2 818.0 797.5 802.9 805.6 806.8 807.5 601.4 601.6 602.4 603.3 604.4 10918.4 10948.7 10982.7 11016.6 11057.8 10817.0 11071.9 11127.2 11217.3 11264.2 9043.6 9158.5 9249.9 9250.6 9261.5 2999.7 3172.4 3212.4 3226.9 3257.7 40981.4 41902.2 42014.4 42035.2 42147.6 8845.6 8914.0 9034.1 9090.0 9141.0 15804.5 15806.0 15820.6 15836.1 15999.9 6231.4 6297.8 6616.8 6732.9 6782.7 3611.6 3656.2 3669.9 3713.2 3734.5 2470.1 2483.7 2495.1 2503.6 2504.9 442.1 444.8 447.3 459.8 461.4 527.6 578.0 587.0 593.3 596.4 6855.1 6982.3 7236.0 7520.2 7666.3 517.5 545.0 545.8 545.8 573.4 3220.8 3266.9 3274.8 3325.4 3638.2 47902.3 48429.8 48496.5 48606.0 48774.3 43123.6 43531.8 43992.0 44077.6 44127.3 38724.8 39506.2 39585.0 39613.8 39749.8 6369.9 6402.4 6501.5 6586.9 6856.6 30516.8 30717.0 31071.0 31586.0 31720.2 36148.8 36962.8 38170.0 38642.8 38670.2 8355.1 8481.7 8659.1 8679.6 8703.0 9169.7 9398.6 9444.8 11216.3 11289.3 9321.0 9553.5 9968.5 10266.2 10823.8 9693.2 9832.9 9853.6 9927.5 10146.8 7948.7 9004.2 9130.7 10000.9 10107.6 8687.8 9008.9 9029.6 9075.6 9156.1 8697.9 8757.9 8777.2 9132.5 9261.4 17:29:20 INFO - PROCESS | 11861 | -------- Summary: end -------- 17:29:20 INFO - PROCESS | 11861 | 17:29:20 INFO - PROCESS | 11861 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:20 INFO - PROCESS | 11861 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:20 INFO - PROCESS | 11861 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:20 INFO - PROCESS | 11861 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:20 INFO - PROCESS | 11861 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:20 INFO - PROCESS | 11861 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:20 INFO - PROCESS | 11861 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:20 INFO - PROCESS | 11861 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:21 INFO - TEST-INFO | 11861: exit 0 17:29:21 INFO - TEST-OK | dromaeo_css | took 1114522ms 17:29:21 INFO - TEST-START | kraken 17:29:21 INFO - operating with platform_type : linux_ 17:29:21 INFO - Initialising browser for kraken test... 17:29:21 INFO - TEST-INFO | started process 12100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOdIcYx/profile http://localhost:33539/getInfo.html) 17:29:25 INFO - PROCESS | 12100 | 17:29:25 INFO - PROCESS | 12100 | (process:12175): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:29:26 INFO - PROCESS | 12100 | __metrics Screen width/height:1600/1200 17:29:26 INFO - PROCESS | 12100 | colorDepth:24 17:29:26 INFO - PROCESS | 12100 | Browser inner width/height: 1024/697 17:29:26 INFO - PROCESS | 12100 | __metrics 17:29:26 ERROR - PROCESS | 12100 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:29:26 INFO - PROCESS | 12100 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:26 INFO - PROCESS | 12100 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:26 INFO - PROCESS | 12100 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:26 INFO - PROCESS | 12100 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:26 INFO - PROCESS | 12100 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:26 INFO - PROCESS | 12100 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:26 INFO - PROCESS | 12100 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:26 INFO - PROCESS | 12100 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:26 INFO - PROCESS | 12100 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:29:27 INFO - TEST-INFO | 12100: exit 0 17:29:27 INFO - Browser initialized. 17:29:27 INFO - Running cycle 1/1 for kraken test... 17:29:27 INFO - TEST-INFO | started process 12226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOdIcYx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:29 INFO - PROCESS | 12226 | 17:29:29 INFO - PROCESS | 12226 | (process:12283): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:29:39 INFO - PROCESS | 12226 | RSS: Main: 161587200 17:29:39 INFO - PROCESS | 12226 | 17:29:42 INFO - PROCESS | 12226 | Cycle 1(1): loaded http://localhost:33539/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33539/tests/kraken/driver.html?testName=audio-beat-detection) 17:29:42 INFO - PROCESS | 12226 | RSS: Main: 168349696 17:29:42 INFO - PROCESS | 12226 | 17:29:45 INFO - PROCESS | 12226 | Cycle 1(1): loaded http://localhost:33539/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33539/tests/kraken/driver.html?testName=audio-dft) 17:29:46 INFO - PROCESS | 12226 | RSS: Main: 170655744 17:29:46 INFO - PROCESS | 12226 | 17:29:49 INFO - PROCESS | 12226 | Cycle 1(1): loaded http://localhost:33539/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33539/tests/kraken/driver.html?testName=audio-fft) 17:29:49 INFO - PROCESS | 12226 | RSS: Main: 164003840 17:29:49 INFO - PROCESS | 12226 | 17:29:51 INFO - PROCESS | 12226 | Cycle 1(1): loaded http://localhost:33539/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33539/tests/kraken/driver.html?testName=audio-oscillator) 17:29:52 INFO - PROCESS | 12226 | RSS: Main: 163213312 17:29:52 INFO - PROCESS | 12226 | 17:29:54 INFO - PROCESS | 12226 | Cycle 1(1): loaded http://localhost:33539/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33539/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:29:55 INFO - PROCESS | 12226 | RSS: Main: 163475456 17:29:55 INFO - PROCESS | 12226 | 17:29:58 INFO - PROCESS | 12226 | Cycle 1(1): loaded http://localhost:33539/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33539/tests/kraken/driver.html?testName=imaging-darkroom) 17:29:59 INFO - PROCESS | 12226 | RSS: Main: 164409344 17:29:59 INFO - PROCESS | 12226 | 17:30:02 INFO - PROCESS | 12226 | Cycle 1(1): loaded http://localhost:33539/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33539/tests/kraken/driver.html?testName=imaging-desaturate) 17:30:03 INFO - PROCESS | 12226 | RSS: Main: 164827136 17:30:03 INFO - PROCESS | 12226 | 17:30:06 INFO - PROCESS | 12226 | Cycle 1(1): loaded http://localhost:33539/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33539/tests/kraken/driver.html?testName=json-parse-financial) 17:30:06 INFO - PROCESS | 12226 | RSS: Main: 164851712 17:30:06 INFO - PROCESS | 12226 | 17:30:08 INFO - PROCESS | 12226 | Cycle 1(1): loaded http://localhost:33539/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33539/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:30:08 INFO - PROCESS | 12226 | RSS: Main: 166359040 17:30:08 INFO - PROCESS | 12226 | 17:30:10 INFO - PROCESS | 12226 | Cycle 1(1): loaded http://localhost:33539/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33539/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:30:11 INFO - PROCESS | 12226 | RSS: Main: 164364288 17:30:11 INFO - PROCESS | 12226 | 17:30:13 INFO - PROCESS | 12226 | Cycle 1(1): loaded http://localhost:33539/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33539/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:30:14 INFO - PROCESS | 12226 | RSS: Main: 164667392 17:30:14 INFO - PROCESS | 12226 | 17:30:16 INFO - PROCESS | 12226 | Cycle 1(1): loaded http://localhost:33539/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33539/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:30:17 INFO - PROCESS | 12226 | RSS: Main: 165203968 17:30:17 INFO - PROCESS | 12226 | 17:30:20 INFO - PROCESS | 12226 | Cycle 1(1): loaded http://localhost:33539/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33539/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:30:20 INFO - PROCESS | 12226 | RSS: Main: 165253120 17:30:20 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | Cycle 1(1): loaded http://localhost:33539/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33539/tests/kraken/driver.html?testName=ai-astar) 17:30:22 INFO - PROCESS | 12226 | RSS: Main: 167628800 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | __start_tp_report 17:30:22 INFO - PROCESS | 12226 | _x_x_mozilla_page_load 17:30:22 INFO - PROCESS | 12226 | _x_x_mozilla_page_load_details 17:30:22 INFO - PROCESS | 12226 | |i|pagename|runs| 17:30:22 INFO - PROCESS | 12226 | |0;ai-astar;116;110;114;116;114;127;114;113;115;116 17:30:22 INFO - PROCESS | 12226 | |1;audio-beat-detection;177;131;157;172;136;164;156;131;168;133 17:30:22 INFO - PROCESS | 12226 | |2;audio-dft;163;162;163;162;162;163;172;162;166;161 17:30:22 INFO - PROCESS | 12226 | |3;audio-fft;75;73;75;75;76;136;76;76;74;74 17:30:22 INFO - PROCESS | 12226 | |4;audio-oscillator;97;98;150;98;97;98;155;97;97;147 17:30:22 INFO - PROCESS | 12226 | |5;imaging-gaussian-blur;122;116;115;116;115;116;115;115;115;115 17:30:22 INFO - PROCESS | 12226 | |6;imaging-darkroom;148;148;148;149;149;147;149;148;149;148 17:30:22 INFO - PROCESS | 12226 | |7;imaging-desaturate;95;98;101;96;96;96;97;101;96;96 17:30:22 INFO - PROCESS | 12226 | |8;json-parse-financial;68;68;72;68;68;68;68;76;66;68 17:30:22 INFO - PROCESS | 12226 | |9;json-stringify-tinderbox;71;71;71;71;71;71;72;73;71;71 17:30:22 INFO - PROCESS | 12226 | |10;stanford-crypto-aes;84;86;86;84;93;86;84;84;85;82 17:30:22 INFO - PROCESS | 12226 | |11;stanford-crypto-ccm;131;128;132;118;131;127;138;139;126;124 17:30:22 INFO - PROCESS | 12226 | |12;stanford-crypto-pbkdf2;140;151;158;149;151;139;153;159;155;137 17:30:22 INFO - PROCESS | 12226 | |13;stanford-crypto-sha256-iterative;71;72;72;71;69;71;71;71;72;69 17:30:22 INFO - PROCESS | 12226 | __end_tp_report 17:30:22 INFO - PROCESS | 12226 | __start_cc_report 17:30:22 INFO - PROCESS | 12226 | _x_x_mozilla_cycle_collect,876 17:30:22 INFO - PROCESS | 12226 | __end_cc_report 17:30:22 INFO - PROCESS | 12226 | __startTimestamp1456795822738__endTimestamp 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | ------- Summary: start ------- 17:30:22 INFO - PROCESS | 12226 | Number of tests: 14 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | [#0] ai-astar Cycles:10 Average:115.50 Median:115.50 stddev:4.43 (3.8%) stddev-sans-first:4.69 17:30:22 INFO - PROCESS | 12226 | Values: 116.0 110.0 114.0 116.0 114.0 127.0 114.0 113.0 115.0 116.0 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:160.50 stddev:18.14 (11.3%) stddev-sans-first:16.94 17:30:22 INFO - PROCESS | 12226 | Values: 177.0 131.0 157.0 172.0 136.0 164.0 156.0 131.0 168.0 133.0 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:3.24 (2.0%) stddev-sans-first:3.43 17:30:22 INFO - PROCESS | 12226 | Values: 163.0 162.0 163.0 162.0 162.0 163.0 172.0 162.0 166.0 161.0 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:19.35 (25.8%) stddev-sans-first:20.40 17:30:22 INFO - PROCESS | 12226 | Values: 75.0 73.0 75.0 75.0 76.0 136.0 76.0 76.0 74.0 74.0 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | [#4] audio-oscillator Cycles:10 Average:113.40 Median:97.00 stddev:25.79 (26.6%) stddev-sans-first:26.66 17:30:22 INFO - PROCESS | 12226 | Values: 97.0 98.0 150.0 98.0 97.0 98.0 155.0 97.0 97.0 147.0 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:115.50 stddev:2.16 (1.9%) stddev-sans-first:0.50 17:30:22 INFO - PROCESS | 12226 | Values: 122.0 116.0 115.0 116.0 115.0 116.0 115.0 115.0 115.0 115.0 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 17:30:22 INFO - PROCESS | 12226 | Values: 148.0 148.0 148.0 149.0 149.0 147.0 149.0 148.0 149.0 148.0 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:96.00 stddev:2.15 (2.2%) stddev-sans-first:2.13 17:30:22 INFO - PROCESS | 12226 | Values: 95.0 98.0 101.0 96.0 96.0 96.0 97.0 101.0 96.0 96.0 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | [#8] json-parse-financial Cycles:10 Average:69.00 Median:68.00 stddev:2.87 (4.2%) stddev-sans-first:3.02 17:30:22 INFO - PROCESS | 12226 | Values: 68.0 68.0 72.0 68.0 68.0 68.0 68.0 76.0 66.0 68.0 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 17:30:22 INFO - PROCESS | 12226 | Values: 71.0 71.0 71.0 71.0 71.0 71.0 72.0 73.0 71.0 71.0 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:2.95 (3.5%) stddev-sans-first:3.09 17:30:22 INFO - PROCESS | 12226 | Values: 84.0 86.0 86.0 84.0 93.0 86.0 84.0 84.0 85.0 82.0 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:131.00 stddev:6.29 (4.8%) stddev-sans-first:6.65 17:30:22 INFO - PROCESS | 12226 | Values: 131.0 128.0 132.0 118.0 131.0 127.0 138.0 139.0 126.0 124.0 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:152.00 stddev:7.93 (5.2%) stddev-sans-first:7.68 17:30:22 INFO - PROCESS | 12226 | Values: 140.0 151.0 158.0 149.0 151.0 139.0 153.0 159.0 155.0 137.0 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 17:30:22 INFO - PROCESS | 12226 | Values: 71.0 72.0 72.0 71.0 69.0 71.0 71.0 71.0 72.0 69.0 17:30:22 INFO - PROCESS | 12226 | -------- Summary: end -------- 17:30:22 INFO - PROCESS | 12226 | 17:30:22 INFO - PROCESS | 12226 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:30:22 INFO - PROCESS | 12226 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:30:22 INFO - PROCESS | 12226 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:30:22 INFO - PROCESS | 12226 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:30:22 INFO - PROCESS | 12226 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:30:22 INFO - PROCESS | 12226 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:30:22 INFO - PROCESS | 12226 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 17:30:23 INFO - TEST-INFO | 12226: exit 0 17:30:23 INFO - TEST-OK | kraken | took 62374ms 17:30:23 INFO - SUITE-END | took 1176s 17:30:23 INFO - Completed test suite (00:19:37) 17:30:23 INFO - Working with test: dromaeo_css 17:30:23 INFO - Generating results file: dromaeo_css 17:30:23 INFO - Working with test: kraken 17:30:23 INFO - Generating results file: kraken 17:30:23 INFO - javascript benchmark 17:30:23 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:30:24 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 17:30:24 INFO - process_Request line: dromaeo_css 6215.13 graph.html#tests=[[72,132,43]] 17:30:24 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:30:24 INFO - process_Request line: kraken 1562.70 graph.html#tests=[[232,132,43]] 17:30:24 INFO - RETURN: dromaeo_css: 6215.13 17:30:24 INFO - RETURN: kraken: 1562.70 17:30:24 INFO - javascript benchmark 17:30:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2654.3629528913066, 2662.6937902141253, 2677.397585543252, 2689.905853295134, 2697.986510067449, 4593.0354625528635, 4593.471750748665, 4613.653975951808, 4618.653600979927, 4673.906521869565, 4662.5803677669, 4683.203855344591, 4690.624750019999, 4691.648126390517, 4716.669833111683, 4291.399204111427, 4315.848945286915, 4334.566543345664, 4428.468583769952, 4477.955220447787, 4118.567550407209, 4225.42956700846, 4392.516823149467, 4426.62373698236, 4440.0, 4308.719933204347, 4310.956890431118, 4340.739555626673, 4355.586219309161, 4381.16757816014, 4295.3771703102875, 4344.087741574273, 4344.522102568715, 4360.280553708634, 4380.123975204971, 4107.63031327179, 4257.74453532789, 4290.927268182954, 4307.483102027777, 4397.010672598672, 4575.702579332333, 4596.03483268514, 4610.9308360374625, 4639.048994956026, 4674.555917187861, 4955.40535135786, 5005.674631148963, 5006.74966251686, 5020.221865610836, 5052.444231134572, 4815.3258543803895, 5012.72430016349, 5051.090803655341, 5123.0, 5137.152369858969, 4624.445066591963, 4650.906981860344, 4654.25531914892, 4659.277811939155, 4696.319033740088, 5114.8977020460125, 5116.309298244763, 5119.436861945183, 5121.718305493159, 5172.793088276502, 4807.110684523374, 4869.70781753096, 4914.533119353656, 4926.310316555685, 4957.157283261854, 4843.782029808667, 5001.24981252815, 5023.6483446159145, 5032.295478632995, 5121.539061484485, 4973.42805577356, 4999.375078115236, 5005.424376196784, 5021.447640759514, 5070.949290507121, 4780.832670856504, 4911.45973942866, 4951.455339912607, 4966.379202599675, 4979.979104283613, 4171.83312667496, 4187.685923555685, 4197.0, 4199.68502362324, 4240.448741663564, 3573.10672331917, 3684.7420680552104, 3709.629037096269, 3710.350688629479, 3727.086863718406, 4331.220380331571, 4348.43470348859, 4357.997660538031, 4368.650507959355, 4407.27279998803, 4980.228064649985, 5015.04714104319, 5024.723640199751, 5034.395872495324, 5044.066847633127, 4220.53574106848, 4312.288472402019, 4362.6946113772365, 4364.934525982113, 4368.716033457815, 4488.035072459437, 4491.910161796745, 4502.774861256924, 4531.13908357411, 4534.88662783433, 4774.188387974053, 4777.187878060738, 4787.61699064081, 4802.759862006886, 4809.254565542346, 4853.951460485491, 4948.084604348207, 5026.52248036436, 5080.517350851663, 5081.644284900021, 4773.952260477351, 4783.258594917794, 4799.1601469743355, 4801.95198048015, 4845.6608037437045, 5001.399832020181, 5002.274670172877, 5012.573931215888, 5015.749212539431, 5032.194848824171, 4892.412910450768, 5025.346704928336, 5047.394312682502, 5084.466131056186, 5126.53861152498, 4870.95129048705, 4884.755762211804, 4892.290617860319, 4911.459739428731, 4925.335079764186, 4879.243717223836, 4889.291052797395, 4892.119418504703, 4905.754712264301, 4925.802967881388, 4587.128445595326, 4716.103940251342, 4739.526047395233, 4779.354787103835, 4831.468538460696, 4871.2206047032305, 4877.756112194305, 4884.65807393479, 4887.486813884633, 4919.163742163769, 4751.382320298339, 4771.856844294677, 4785.545373189541, 4797.208460603962, 4800.855974320776], "unit": "score", "name": "dojo.html", "value": 4601.624110590625}, {"lowerIsBetter": false, "replicates": [501.8143286983814, 514.7066172281799, 529.8860744939838, 544.4093158922569, 550.4962958892613, 34998.82500587497, 35610.82194589027, 35763.4635480468, 35767.0, 35900.0, 36721.08197295069, 37038.814805926, 37456.438153427654, 37498.62501374986, 37524.0, 7549.7735067947915, 7837.529748215125, 7840.098388685288, 7868.4098692598, 7875.645595948167, 7544.509606875563, 7679.116901556309, 7696.037995250594, 7705.845883082335, 7718.961405192967, 7668.4248681348845, 7683.500572462772, 7700.614969251543, 7705.383569314469, 7727.768166955, 7638.618069096523, 7682.961585192038, 7725.575093369891, 7734.613269336511, 7761.068671759369, 7618.8095297618, 7681.3854891608535, 7690.192529784404, 7712.460127791057, 7728.072631284225, 33195.834020829985, 33567.16082097943, 33653.0, 33664.32671346559, 33687.66312336894, 1858.4238885945401, 2586.405126820842, 2699.5140874642557, 2736.7126451722484, 2741.8080734348605, 24815.25554233358, 27121.321966950785, 28157.155285341472, 28375.57436638452, 28512.85948562055, 3080.1067690369764, 3082.2631030892094, 3123.422166899131, 3125.4217969675683, 3161.683831616843, 218673.0, 220420.0, 220424.8978755112, 221223.0, 221585.0, 52649.473505265225, 52715.0, 52965.20552191643, 53080.469195308324, 53214.20178697323, 56407.15389269164, 58471.0, 60578.0, 60610.39389606047, 60792.696036519534, 12313.26120432777, 12450.75098498043, 12485.375731213402, 12520.186187897758, 12554.686132846751, 8564.914350856536, 8612.0, 8616.827663446697, 8620.0, 8630.956845215735, 18347.816521834877, 18408.539786505444, 18444.538886527946, 18503.53741156455, 18585.721214181798, 7749.108852482037, 7995.880061799077, 8039.47743396689, 8091.271785539329, 8149.592520373958, 807.2169995104739, 899.3434792601438, 943.6649989253854, 1013.2198207380276, 1029.4543891737392, 25644.487110258062, 26078.739212608012, 26190.476190476085, 26208.34479138037, 26888.59667104995, 914.4558987402485, 987.0820137272406, 1024.8565200871883, 1047.471027131309, 1051.994740026295, 13652.112612680145, 13843.86156138446, 13943.372548235353, 14015.579532614038, 14279.286035698173, 260609.0, 262587.0, 264035.0, 266078.0, 266272.0, 45597.31604025942, 46013.76993115013, 46067.76966115148, 46082.30876536854, 46121.769391152826, 1149.7528031473273, 1197.5569039455283, 1222.2971791220084, 1226.632304979941, 1226.7546490701895, 24581.262562123164, 25486.362840929127, 25489.872550637127, 25753.484930301664, 25781.87109064443, 39562.80218598888, 39623.60376396199, 39629.80185099056, 39694.80152599334, 39860.601393985686, 209473.0, 209480.0, 210338.0, 211142.0, 211327.0, 29344.11967640974, 29788.255293617833, 29843.552346714383, 38856.41715374215, 39766.0, 34584.13539661428, 34703.0, 34733.0, 35185.296294074484, 35191.824040879634, 32376.676233238308, 32435.0, 33253.66746332506, 33303.83348083244, 33417.66582334146, 32584.83707581447, 32627.34745305128, 33022.83488582542, 33248.66751332456, 33754.493682595275, 32909.17727056843, 32964.50553241655, 33107.834460827544, 33368.49947250842, 33746.32507349888, 29120.0, 31174.532382014742, 31440.213994650316, 32751.34497310088, 32774.0, 22537.887310563343, 22900.656490152327, 22980.655290170325, 23488.64767028462, 24197.274081777574], "unit": "score", "name": "ext.html", "value": 16365.863467025469}, {"lowerIsBetter": false, "replicates": [339.9507071474636, 340.1733786897837, 344.392147859029, 345.39383382164306, 347.4961306106145, 15290.847091529082, 15650.217489125542, 16262.756058659115, 16279.755803662925, 16315.673686526263, 14893.627659308522, 15191.46829860955, 15277.6944461111, 15506.302216400261, 15555.766663500028, 4884.633652476061, 5120.950205207923, 5124.282600435942, 5143.81996630118, 5157.149070403379, 6014.909776353358, 6299.464545513637, 6304.085907543404, 6309.116723658692, 6325.240971083476, 6091.14723938649, 6259.403852017729, 6635.701393437307, 6661.700223489955, 6672.59964402135, 6525.510586705992, 6549.083128362057, 6559.573627714207, 6583.736650533973, 6584.473242140617, 5883.911741323884, 6156.722947467375, 6161.938380616226, 6162.1681073055015, 6163.322034576193, 18802.81197188038, 20814.687779683318, 21337.253196138216, 21715.34853954368, 21848.453788655253, 1790.149678902511, 1892.1863598652574, 2004.7594288685304, 2162.740471143473, 2683.409649877024, 12866.099373043891, 13372.799408008888, 13382.799258011137, 13446.596602101952, 13662.18026918388, 1856.786469556005, 1864.5245462407136, 1903.2196799312217, 1919.9712004319947, 1926.4509614759866, 45198.54801452009, 51600.48399515994, 51874.48125518772, 53682.19476707852, 53777.19334209951, 14567.198804065878, 15029.0, 15249.313780879887, 15301.693966120616, 15825.52523424299, 22925.541489170457, 23211.419714507272, 23224.3032709019, 23234.767652323597, 23293.767062329498, 7187.173475050332, 7342.339189472973, 7385.261473852679, 7545.773626791205, 7574.015378000825, 6022.337542870281, 6044.818655440344, 6134.693265336716, 6224.751009959641, 6315.747370105236, 7687.0, 7762.068551773823, 7812.492188007761, 7814.452988290879, 7882.763517094496, 3189.1070500259966, 3246.318273162662, 3265.9020229393154, 3281.8194999274792, 3375.628680845105, 385.7723942873718, 392.6583872031351, 411.7488332117406, 411.94232807406985, 779.9571023593643, 8954.641814327353, 9471.0, 9665.516724163763, 9687.806243875224, 9786.461744603972, 410.5627506705349, 430.54362375881664, 432.0775145065308, 437.90803931174173, 444.25143632978535, 5416.458354164552, 5443.292371991616, 5473.233747275384, 5546.528545073633, 5570.860728481739, 367599.0, 367852.0, 368186.0, 371115.0, 375606.0, 66118.33881661217, 66150.66924665346, 66487.66756166285, 67974.66012669905, 68811.65594172098, 373.16038912446993, 412.34643090701576, 426.4009067260442, 426.90181258310764, 429.05179553187804, 9506.857397139187, 9535.618575256913, 9599.616015359308, 9610.327277090537, 9659.517024148905, 27977.72022279751, 28686.0, 28914.710852892043, 29029.709702903547, 29897.252568685086, 37235.0, 40393.39409908795, 42900.35649465323, 43524.56475435205, 44251.778741106085, 6407.71165297572, 6499.122618446449, 6687.130673012477, 6698.062271282122, 6716.429103526255, 9553.47455889905, 9561.187299079656, 9691.0, 9959.850602240827, 10090.596376144871, 8432.988041435066, 8529.317654587494, 8543.786405339917, 8763.298936085226, 8995.640174393213, 6871.03805467245, 8885.200331969894, 8893.555322233991, 9328.860067099135, 9620.172167288192, 9081.636734530544, 9218.170364667212, 9262.16640502358, 9666.371685840399, 9725.610975560898, 6927.965360173167, 7052.506324557232, 7093.787186384417, 7188.065551478275, 7207.243239459991, 7072.0, 8796.692115775917, 9302.860457093284, 9528.380655257386, 9565.665201717906], "unit": "score", "name": "jquery.html", "value": 7630.790902528268}, {"lowerIsBetter": false, "replicates": [1347.5755137131803, 1370.5614203454893, 1485.9331330090145, 1702.361614394602, 1718.1752758675834, 5967.4927631151295, 6939.618320992344, 7070.116235470567, 7299.416046716263, 7304.086989126353, 7128.5366451180635, 7148.213696493382, 7172.31862973018, 7222.133343998715, 7222.494425390225, 2085.16593362655, 2111.3876975677035, 2112.207922029239, 2121.469632591852, 2122.5118222808765, 2063.4531849060013, 2065.2874758208395, 2066.0599427260636, 2102.127617038927, 2105.9684104738367, 2049.9897500512475, 2089.9791002089937, 2102.547952190279, 2109.8101170894615, 2119.3324102907613, 2075.522629795148, 2079.199508189343, 2083.9791602084088, 2084.9791502085013, 2085.7914208579173, 2065.659166237569, 2085.405659387083, 2097.2974053692033, 2107.4415279950827, 2109.325015994882, 7310.195878453366, 7317.524360916524, 7389.371903388218, 7397.075365579302, 7404.629768511553, 4277.572242775728, 4342.891427714301, 4361.542038086019, 4383.079553293812, 4390.956090439086, 2678.9598156027673, 2720.8503532305717, 2768.197222805384, 2792.2321361625513, 2806.789490788199, 853.8292341531718, 1610.8630766384754, 1626.1137679964447, 1642.2691902103568, 1657.2625181794106, 9469.431834089908, 9498.810023799555, 9508.85736713943, 9530.189933855561, 9538.904610953941, 3758.2107757370713, 3882.825272862728, 3890.8249128788707, 3918.8432462701744, 3920.941185882214, 7692.076950765944, 7714.498557593738, 7721.498102623312, 7732.188120247293, 7754.6898124074405, 4236.3857240700545, 4253.319468885025, 4258.063226090255, 4280.186764514795, 4282.464691913511, 3171.1120886151916, 3775.5091838060875, 3844.1735026968777, 3850.614938506127, 3873.7288389812443, 3149.5590617313596, 3178.9682103179134, 3204.8878289259765, 3218.5011323244466, 3225.822579758136, 945.9337846350827, 973.2408721197477, 973.3089506450358, 978.0854900667898, 988.8961659025842, 864.9394542381973, 892.3753372639178, 1162.3490845126755, 1163.0288708927972, 1189.9881001190051, 6719.260881303053, 6726.293739157416, 6745.190577130776, 6748.763793267212, 6816.216135144423, 1047.7171163785736, 1066.632011955874, 1072.7639919217759, 1090.4493230918335, 1093.1965005720788, 5321.467853214725, 5350.38470575881, 5367.463253674601, 5398.325209348832, 5399.163129714901, 8537.957310213409, 8984.595693193822, 8987.281017518582, 9013.819723605622, 9029.187373136449, 8777.561121943878, 8813.647454101892, 8841.0, 8882.911170888337, 8933.865992010125, 6764.898526522106, 6959.338862808025, 6979.4416446684145, 6996.090508233999, 7014.719411223494, 6664.533482656361, 6666.799996000128, 6667.066610674412, 6685.09751183584, 6687.09724187248, 7809.492382995087, 7906.881396778937, 7941.047074351115, 7998.760037198894, 7999.040115186215, 7497.925020749941, 7782.961085194538, 7795.649195786316, 7847.254510821463, 7883.408744344082, 5123.897522049613, 6030.0, 6099.0, 6130.386961304012, 6271.560990730605, 6834.419074378733, 6847.281035491202, 6848.760293389708, 6882.896756548756, 6884.65576721152, 5846.707664616837, 5969.940300596939, 6008.279006519246, 6022.759089636365, 6022.819315420545, 5930.584859059824, 5933.940660593339, 6022.789202377896, 6043.244594425697, 6044.607100538451, 6209.285932117684, 6244.500439964701, 6366.554341196072, 6437.678116094083, 6444.065610486359, 5942.0, 5973.731182096729, 5988.6706231157705, 6026.276846778414, 6035.668038257938, 5922.615030023035, 6069.51443884497, 6074.36219196978, 6090.878182436415, 6099.9390006099375], "unit": "score", "name": "mootools.html", "value": 4145.639968572822}, {"lowerIsBetter": false, "replicates": [289.8376908930999, 298.18892612095095, 302.8909592546683, 303.5477139062797, 308.46019465934614, 5674.375818659944, 5741.138829175626, 5751.65490070596, 5762.193292938987, 5785.971070144644, 5647.661140331583, 5659.745311460983, 5660.801871934483, 5665.886682266362, 5679.886402271952, 4018.8392464301464, 4185.351270553069, 4281.314989601664, 4281.785910704468, 4295.140971805636, 4257.701960862741, 4308.719933204347, 4347.630451411634, 4350.238708226064, 4355.912881742363, 4283.892902677442, 4286.357046443043, 4299.3550967354995, 4305.354196870463, 4311.892202694927, 4289.764062976535, 4294.935575966363, 4295.205387003399, 4303.634191093745, 4317.0934103838235, 3761.285355782393, 3769.754965927206, 3770.9245815083545, 3776.3957766757185, 3782.3569993100964, 5442.319710036246, 5446.319210098738, 5450.863728406782, 5464.644798088151, 5467.043267428184, 4706.5293470653005, 4841.70949743013, 4901.411830580318, 4922.680025798311, 5025.447200807908, 5931.258592675916, 5936.22829032223, 5950.077737950624, 5950.285965684102, 5956.315023772235, 3982.8008599570194, 3987.6809855211513, 3990.06233535119, 3990.2618015666903, 3993.7204395692315, 6200.069989501566, 6232.8130156095385, 6263.31103578606, 6268.905966410507, 6270.905936410957, 4097.221527909687, 4099.959000410017, 4100.077482566398, 4100.36444351126, 4107.301758701028, 4160.646345060703, 4162.5629308922125, 4164.541900390955, 4166.687498437629, 4168.603982621707, 4639.8144074237325, 4804.975975120172, 4813.831515896927, 4819.6867203631655, 4819.879503012453, 5886.411358864165, 5963.642181469126, 5966.433188847052, 5972.074328479092, 5989.610675306091, 1444.6316189371644, 1466.6773309871812, 1471.0879254862054, 1471.977920331196, 1473.9336729847182, 949.710338346797, 959.7216807125856, 972.8881178664402, 976.1019861727228, 977.452626529146, 5169.276301317818, 5180.689158650418, 5183.170692689227, 5190.455002224788, 5192.4807519248525, 6126.663033533109, 6153.784617538365, 6185.536084793568, 6192.380761923771, 6202.131701561785, 5049.394072711299, 5153.1497302945345, 5162.174052151638, 5210.687358758487, 5260.210968354778, 3352.597688277422, 3387.0, 3387.1024178592693, 3389.305192435545, 3391.847366868497, 5812.244408226903, 5863.413658634103, 5874.676892770854, 5879.882402352015, 5884.911726324109, 6427.453666438405, 6446.645434501147, 6451.9354806452275, 6452.870942581122, 6458.580192287486, 5853.268341457318, 5862.794802181903, 5866.941330586725, 5868.0, 5890.322612899486, 6053.424924632153, 6159.353267906985, 6248.062790581449, 6259.467945224706, 6265.8120256392385, 6125.816225513242, 6142.600730952474, 6149.139120523041, 6158.076288556752, 6158.32258451561, 5853.297604287342, 5859.5019423349495, 5885.058390657646, 5885.735141918538, 5887.264091988502, 4074.4703188585295, 4113.424120623175, 4115.54728979818, 4116.259073366823, 4120.011197312683, 6199.16311297969, 6233.844153896189, 6235.844103897439, 6269.96865015672, 6278.8430289241305, 5792.189093526826, 6001.549883758648, 6019.307779605227, 6031.5777895548645, 6033.9698301508215, 6014.6391216527145, 6022.668753218615, 6027.246594175728, 6055.182550355646, 6067.362926892612, 5874.853128671817, 5878.088896221093, 5883.117532370179, 5898.469137777621, 5902.468777810018, 6050.485708714808, 6058.0610005449225, 6060.515158787198, 6084.300305464928, 6087.965045942112, 5711.914321285101, 5905.527557795452, 5921.733521991435, 5923.674197918984, 5931.08068249422], "unit": "score", "name": "prototype.html", "value": 4427.357582006569}, {"lowerIsBetter": false, "replicates": [642.3415998601433, 654.1463390275694, 665.1187176990486, 686.4611280145087, 691.7924622613216, 9839.901600983989, 9911.851322230154, 9940.751481212974, 9944.850827237578, 10598.576056957721, 11379.886201137986, 12716.427760750765, 12894.93552532236, 12931.935340323285, 12968.481260749559, 700.58315302395, 772.3087836386417, 778.2101167315179, 784.5410434895593, 786.1077676836775, 771.9382449404034, 774.5623722596742, 774.8721460958935, 775.7944144801633, 778.6534991928594, 804.3645520039162, 813.2639960835453, 813.422470046265, 816.244973399606, 817.9550124743137, 797.4856217739525, 802.9437939344219, 805.5851236613149, 806.770070529902, 807.4670717326536, 601.4316470934968, 601.5909181756404, 602.3705228036712, 603.3182503770755, 604.3714536881638, 10918.399488028155, 10948.726281842937, 10982.670519884416, 11016.614418495314, 11057.834132488018, 10817.0, 11071.889281107166, 11127.165462590257, 11217.270877393024, 11264.21150519464, 9043.59303831329, 9158.542072896329, 9249.936257330426, 9250.583723732449, 9261.536923153883, 2999.6700362960273, 3172.38138562978, 3212.405704944593, 3226.8547915343865, 3257.690519400653, 40981.385279220834, 41902.1619567607, 42014.36978445326, 42035.1592968142, 42147.578524214674, 8845.601947912359, 8913.955430222937, 9034.096590340914, 9090.0, 9140.954295228614, 15804.525864224091, 15806.0, 15820.60448488797, 15836.129012904401, 15999.920000399923, 6231.376862313732, 6297.842553936188, 6616.8345791355605, 6732.932670673328, 6782.694778734969, 3611.602723700443, 3656.213914008501, 3669.9266014679556, 3713.220223752988, 3734.477173195755, 2470.0984140788482, 2483.726790053093, 2495.1017633651873, 2503.561876671575, 2504.9373765656005, 442.14665695208555, 444.76649758876204, 447.2843450479272, 459.75862672096747, 461.4462644826155, 527.5911168844176, 577.9508741756914, 587.0121083684069, 593.3443544882842, 596.3887015808831, 6855.108835851307, 6982.2879808099215, 7236.00715506299, 7520.247975202436, 7666.271704188093, 517.5083670513028, 544.9700266485302, 545.7871430142247, 545.8198794397919, 573.3864764701813, 3220.8101667990563, 3266.852991615383, 3274.836258187129, 3325.3515564465183, 3638.21778317663, 47902.28146577804, 48429.75785121052, 48496.5150348492, 48606.0, 48774.26838597424, 43123.568764312586, 43531.78234108809, 43992.0, 44077.55922440799, 44127.33808992868, 38724.80637596794, 39506.20987580232, 39585.0, 39613.80193099016, 39749.80125099414, 6369.90445143314, 6402.35976402356, 6501.544891857525, 6586.901196482152, 6856.588604683735, 30516.847415763667, 30717.0, 31071.0, 31586.0, 31720.206994825316, 36148.81925590355, 36962.81518592498, 38170.0, 38642.80678596589, 38670.22659546737, 8355.080941096596, 8481.745547633582, 8659.090795466385, 8679.566021699016, 8702.956485217534, 9169.679061232824, 9398.624055037995, 9444.763880903032, 11216.327020378803, 11289.266197697123, 9320.95339523298, 9553.474558899326, 9968.451735154636, 10266.178705703376, 10823.783524329627, 9693.176080033276, 9832.901670983485, 9853.556589953612, 9927.453990030617, 10146.847797282899, 7948.682052717826, 9004.189622933967, 9130.680426185052, 10000.899991000288, 10107.595696172071, 8687.782805429662, 9008.901308547118, 9029.593668284811, 9075.591598378222, 9156.130167634064, 8697.91302086971, 8757.91242087571, 8777.166169213915, 9132.543372831466, 9261.351705380559], "unit": "score", "name": "yui.html", "value": 5463.928918511041}], "name": "dromaeo_css", "value": 6215.131023756424}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 110.0, 114.0, 116.0, 114.0, 127.0, 114.0, 113.0, 115.0, 116.0], "unit": "score", "name": "ai-astar", "value": 115.5}, {"lowerIsBetter": true, "replicates": [177.0, 131.0, 157.0, 172.0, 136.0, 164.0, 156.0, 131.0, 168.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 152.5}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 163.0, 162.0, 162.0, 163.0, 172.0, 162.0, 166.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 75.0, 75.0, 76.0, 136.0, 76.0, 76.0, 74.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 150.0, 98.0, 97.0, 98.0, 155.0, 97.0, 97.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 113.4}, {"lowerIsBetter": true, "replicates": [122.0, 116.0, 115.0, 116.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.0}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 149.0, 149.0, 147.0, 149.0, 148.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.3}, {"lowerIsBetter": true, "replicates": [95.0, 98.0, 101.0, 96.0, 96.0, 96.0, 97.0, 101.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 72.0, 68.0, 68.0, 68.0, 68.0, 76.0, 66.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 69.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 71.0, 71.0, 71.0, 72.0, 73.0, 71.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.3}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 86.0, 84.0, 93.0, 86.0, 84.0, 84.0, 85.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [131.0, 128.0, 132.0, 118.0, 131.0, 127.0, 138.0, 139.0, 126.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.4}, {"lowerIsBetter": true, "replicates": [140.0, 151.0, 158.0, 149.0, 151.0, 139.0, 153.0, 159.0, 155.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.2}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 71.0, 69.0, 71.0, 71.0, 71.0, 72.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1562.7000000000003}]} 17:30:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1562.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6215.13"}}} 17:30:24 INFO - Return code: 0 17:30:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:30:24 ERROR - # TBPL SUCCESS # 17:30:24 INFO - Running post-action listener: _resource_record_post_action 17:30:24 INFO - Running post-run listener: _resource_record_post_run 17:30:25 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535764992; Read time: 8; Write time: 472768 17:30:25 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243982336; Read time: 0; Write time: 268392 17:30:25 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291782656; Read time: 8; Write time: 204376 17:30:25 INFO - Running post-run listener: _upload_blobber_files 17:30:25 INFO - Blob upload gear active. 17:30:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:30:25 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 17:30:25 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'] 17:30:25 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 17:30:25 INFO - (blobuploader) - INFO - Open directory for files ... 17:30:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:30:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:30:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:26 INFO - (blobuploader) - INFO - Done attempting. 17:30:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:30:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:30:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:27 INFO - (blobuploader) - INFO - Done attempting. 17:30:27 INFO - (blobuploader) - INFO - Iteration through files over. 17:30:27 INFO - Return code: 0 17:30:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:30:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:30:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/77413e131f74adf407cb6f4b1fa387a0e6cfd25c63858042ce6b3ebfba61b5074bfb833e4ce460eaddd294ebcf00b5bee5fbea2f80577b655efc42c1f7b0ae10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c84e00410f792f9e17102eaa25bf4fb0c4b99d0b5eb12b818e4ceb0989266723bd6edd0b145f2784210b2fe8eaf86b94f791213993502b391728158d89cfa9fd"} 17:30:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:30:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:30:27 INFO - Contents: 17:30:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/77413e131f74adf407cb6f4b1fa387a0e6cfd25c63858042ce6b3ebfba61b5074bfb833e4ce460eaddd294ebcf00b5bee5fbea2f80577b655efc42c1f7b0ae10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c84e00410f792f9e17102eaa25bf4fb0c4b99d0b5eb12b818e4ceb0989266723bd6edd0b145f2784210b2fe8eaf86b94f791213993502b391728158d89cfa9fd"} 17:30:27 INFO - Running post-run listener: copy_logs_to_upload_dir 17:30:27 INFO - Copying logs to upload dir... 17:30:27 INFO - mkdir: /builds/slave/test/build/upload/logs 17:30:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.028254 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-02-29 17:30:27.415612) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 17:30:27.419376) ========= 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=6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303 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/77413e131f74adf407cb6f4b1fa387a0e6cfd25c63858042ce6b3ebfba61b5074bfb833e4ce460eaddd294ebcf00b5bee5fbea2f80577b655efc42c1f7b0ae10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c84e00410f792f9e17102eaa25bf4fb0c4b99d0b5eb12b818e4ceb0989266723bd6edd0b145f2784210b2fe8eaf86b94f791213993502b391728158d89cfa9fd"} build_url:https://queue.taskcluster.net/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/RrBYuBqURxGG3Nrth4a6bw/artifacts/public/build/firefox-47.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/77413e131f74adf407cb6f4b1fa387a0e6cfd25c63858042ce6b3ebfba61b5074bfb833e4ce460eaddd294ebcf00b5bee5fbea2f80577b655efc42c1f7b0ae10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c84e00410f792f9e17102eaa25bf4fb0c4b99d0b5eb12b818e4ceb0989266723bd6edd0b145f2784210b2fe8eaf86b94f791213993502b391728158d89cfa9fd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 17:30:27.443555) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:30:27.443852) ========= 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=6d15e502d8e29d5d2676d664000001c3-1456791161.347687-1149657303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 17:30:27.525813) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 17:30:27.526152) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 17:30:27.526453) ========= ========= Total master_lag: 0.26 =========