builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1494423344.11 results: success (0) revision: 8ad5338081026c48029d72f1e6c1668a58489bec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 06:35:44.108946) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-10 06:35:44.109417) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 06:35:44.109697) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-10 06:35:44.124619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:35:44.124914) ========= 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=0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-10 06:35:44-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2017-05-10 06:35:44 (46.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.215331 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:35:44.357530) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:35:44.357837) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020099 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:35:44.407137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-10 06:35:44.410497) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8ad5338081026c48029d72f1e6c1668a58489bec --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 8ad5338081026c48029d72f1e6c1668a58489bec --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=0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-10 06:35:44,757 truncating revision to first 12 chars 2017-05-10 06:35:44,757 Setting DEBUG logging. 2017-05-10 06:35:44,757 attempt 1/10 2017-05-10 06:35:44,757 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8ad533808102?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-10 06:35:45,106 unpacking tar archive at: mozilla-central-8ad533808102/testing/mozharness/ program finished with exit code 0 elapsedTime=1.419476 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-10 06:35:45.846412) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 06:35:45.846734) ========= script_repo_revision: 8ad5338081026c48029d72f1e6c1668a58489bec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-10 06:35:45.847105) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 06:35:45.847363) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-10 06:35:45.857175) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-10 06:35:45.857453) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:35:46 INFO - MultiFileLogger online at 20170510 06:35:46 in /builds/slave/test 06:35:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:35:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:35:46 INFO - {'append_to_log': False, 06:35:46 INFO - 'base_work_dir': '/builds/slave/test', 06:35:46 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:35:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:35:46 INFO - 'branch': 'Firefox-Non-PGO', 06:35:46 INFO - 'buildbot_json_path': 'buildprops.json', 06:35:46 INFO - 'config_files': ('talos/linux_config.py',), 06:35:46 INFO - 'default_actions': ('clobber', 06:35:46 INFO - 'read-buildbot-config', 06:35:46 INFO - 'download-and-extract', 06:35:46 INFO - 'populate-webroot', 06:35:46 INFO - 'create-virtualenv', 06:35:46 INFO - 'install', 06:35:46 INFO - 'run-tests'), 06:35:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:35:46 INFO - 'download_minidump_stackwalk': True, 06:35:46 INFO - 'download_symbols': 'ondemand', 06:35:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:35:46 INFO - 'tooltool.py': '/tools/tooltool.py', 06:35:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:35:46 INFO - '/tools/misc-python/virtualenv.py')}, 06:35:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:35:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:35:46 INFO - 'gecko_profile': False, 06:35:46 INFO - 'gecko_profile_interval': 0, 06:35:46 INFO - 'installer_path': 'installer.exe', 06:35:46 INFO - 'log_level': 'info', 06:35:46 INFO - 'log_name': 'talos', 06:35:46 INFO - 'log_to_console': True, 06:35:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:35:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:35:46 INFO - 'opt_config_files': (), 06:35:46 INFO - 'pip_index': False, 06:35:46 INFO - 'suite': 'dromaeojs', 06:35:46 INFO - 'system_bits': '32', 06:35:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:35:46 INFO - 'title': 'talos-linux64-ix-017', 06:35:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:35:46 INFO - 'use_talos_json': True, 06:35:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:35:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:35:46 INFO - 'work_dir': 'build'} 06:35:46 INFO - [mozharness: 2017-05-10 13:35:46.302923Z] Running clobber step. 06:35:46 INFO - Running pre-action listener: _resource_record_pre_action 06:35:46 INFO - Running main action method: clobber 06:35:46 INFO - rmtree: /builds/slave/test/build 06:35:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:35:47 INFO - Running post-action listener: _resource_record_post_action 06:35:47 INFO - [mozharness: 2017-05-10 13:35:47.298534Z] Finished clobber step (success) 06:35:47 INFO - [mozharness: 2017-05-10 13:35:47.298634Z] Running read-buildbot-config step. 06:35:47 INFO - Running pre-action listener: _resource_record_pre_action 06:35:47 INFO - Running main action method: read_buildbot_config 06:35:47 INFO - Using buildbot properties: 06:35:47 INFO - { 06:35:47 INFO - "project": "", 06:35:47 INFO - "product": "firefox", 06:35:47 INFO - "who": "cbook@mozilla.com", 06:35:47 INFO - "installer_path": "public/build/target.tar.bz2", 06:35:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:35:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:35:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:35:47 INFO - "stage_platform": "linux64", 06:35:47 INFO - "basedir": "/builds/slave/test", 06:35:47 INFO - "buildnumber": 592, 06:35:47 INFO - "platform": "ubuntu64_hw", 06:35:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:35:47 INFO - "slavebuilddir": "test", 06:35:47 INFO - "taskId": "KE33fWFXQJul2B9gitJetg", 06:35:47 INFO - "branch": "mozilla-central", 06:35:47 INFO - "script_repo_revision": "production", 06:35:47 INFO - "revision": "8ad5338081026c48029d72f1e6c1668a58489bec", 06:35:47 INFO - "slavename": "talos-linux64-ix-017", 06:35:47 INFO - "repo_path": "mozilla-central" 06:35:47 INFO - } 06:35:47 INFO - Finding installer, test and symbols from parent task. 06:35:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KE33fWFXQJul2B9gitJetg'}, attempt #1 06:35:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KE33fWFXQJul2B9gitJetg'}, attempt #1 06:35:48 INFO - Task dependencies: C-8W5w8iT-ikMnRjWDqBYQ 06:35:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ'}, attempt #1 06:35:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2 06:35:48 INFO - Set test_url: https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/test_packages.json 06:35:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.crashreporter-symbols.zip 06:35:48 INFO - Running post-action listener: _resource_record_post_action 06:35:48 INFO - [mozharness: 2017-05-10 13:35:48.648442Z] Finished read-buildbot-config step (success) 06:35:48 INFO - [mozharness: 2017-05-10 13:35:48.648658Z] Running download-and-extract step. 06:35:48 INFO - Running pre-action listener: _resource_record_pre_action 06:35:48 INFO - Running main action method: download_and_extract 06:35:48 INFO - mkdir: /builds/slave/test/build/tests 06:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:48 INFO - trying https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.test_packages.json 06:35:48 INFO - Downloading https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:35:49 INFO - Downloaded 986 bytes. 06:35:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:35:49 INFO - Using the following test package requirements: 06:35:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:35:49 INFO - u'common': [u'target.common.tests.zip'], 06:35:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:35:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:35:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:35:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:35:49 INFO - u'mozbase': [u'target.common.tests.zip'], 06:35:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:35:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:35:49 INFO - u'web-platform': [u'target.common.tests.zip', 06:35:49 INFO - u'target.web-platform.tests.zip'], 06:35:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:35:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:35:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.common.tests.zip 06:35:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:35:49 INFO - Fetch https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.common.tests.zip into memory 06:35:50 INFO - Content-Length response header: 58446126 06:35:50 INFO - Bytes received: 58446126 06:36:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:36:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.common.tests.zip 06:36:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:36:00 INFO - Fetch https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.common.tests.zip into memory 06:36:01 INFO - Content-Length response header: 58446126 06:36:01 INFO - Bytes received: 58446126 06:36:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.talos.tests.zip 06:36:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:36:12 INFO - Fetch https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.talos.tests.zip into memory 06:36:12 INFO - Content-Length response header: 14409362 06:36:12 INFO - Bytes received: 14409362 06:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:13 INFO - trying https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2 06:36:13 INFO - Downloading https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:36:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:36:14 INFO - Downloaded 62982752 bytes. 06:36:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2 06:36:14 INFO - mkdir: /builds/slave/test/properties 06:36:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:36:14 INFO - Writing to file /builds/slave/test/properties/build_url 06:36:14 INFO - Contents: 06:36:14 INFO - build_url:https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2 06:36:14 INFO - Running post-action listener: _resource_record_post_action 06:36:14 INFO - Running post-action listener: set_extra_try_arguments 06:36:14 INFO - [mozharness: 2017-05-10 13:36:14.410066Z] Finished download-and-extract step (success) 06:36:14 INFO - [mozharness: 2017-05-10 13:36:14.410164Z] Running populate-webroot step. 06:36:14 INFO - Running pre-action listener: _resource_record_pre_action 06:36:14 INFO - Running main action method: populate_webroot 06:36:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:36:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:36:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:36:14 INFO - '--tppagecycles', 06:36:14 INFO - '7'], 06:36:14 INFO - 'tests': ['tsvgm']}}, 06:36:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:36:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:36:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:36:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:36:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:36:14 INFO - 'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:36:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:36:14 INFO - 'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['damp', 'tps']}, 06:36:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:36:14 INFO - 'tests': ['damp', 'tps']}, 06:36:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['dromaeo_dom']}, 06:36:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:36:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:36:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:36:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['a11yr', 06:36:14 INFO - 'ts_paint', 06:36:14 INFO - 'tpaint', 06:36:14 INFO - 'sessionrestore', 06:36:14 INFO - 'sessionrestore_no_auto_restore', 06:36:14 INFO - 'tabpaint']}, 06:36:14 INFO - 'other-e10s': {'tests': ['a11yr', 06:36:14 INFO - 'ts_paint', 06:36:14 INFO - 'tpaint', 06:36:14 INFO - 'sessionrestore', 06:36:14 INFO - 'sessionrestore_no_auto_restore', 06:36:14 INFO - 'tabpaint']}, 06:36:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:36:14 INFO - 'ts_paint', 06:36:14 INFO - 'tpaint', 06:36:14 INFO - 'sessionrestore', 06:36:14 INFO - 'sessionrestore_no_auto_restore', 06:36:14 INFO - 'tabpaint']}, 06:36:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:36:14 INFO - 'ts_paint', 06:36:14 INFO - 'tpaint', 06:36:14 INFO - 'sessionrestore', 06:36:14 INFO - 'sessionrestore_no_auto_restore', 06:36:14 INFO - 'tabpaint']}, 06:36:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['a11yr', 06:36:14 INFO - 'ts_paint', 06:36:14 INFO - 'tpaint', 06:36:14 INFO - 'sessionrestore', 06:36:14 INFO - 'sessionrestore_no_auto_restore', 06:36:14 INFO - 'tabpaint']}, 06:36:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['a11yr', 06:36:14 INFO - 'ts_paint', 06:36:14 INFO - 'tpaint', 06:36:14 INFO - 'sessionrestore', 06:36:14 INFO - 'sessionrestore_no_auto_restore', 06:36:14 INFO - 'tabpaint']}, 06:36:14 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:36:14 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:36:14 INFO - 'bloom_basic_ref']}, 06:36:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['tsvgx', 06:36:14 INFO - 'tsvgr_opacity', 06:36:14 INFO - 'tart', 06:36:14 INFO - 'tscrollx', 06:36:14 INFO - 'cart', 06:36:14 INFO - 'tsvg_static']}, 06:36:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:36:14 INFO - 'tsvgr_opacity', 06:36:14 INFO - 'tart', 06:36:14 INFO - 'tscrollx', 06:36:14 INFO - 'cart', 06:36:14 INFO - 'tsvg_static']}, 06:36:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:36:14 INFO - 'talos_options': ['--disable-e10s'], 06:36:14 INFO - 'tests': ['tp5o']}, 06:36:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:36:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:36:14 INFO - 'talos_options': ['--disable-e10s', 06:36:14 INFO - '--xperf_path', 06:36:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:14 INFO - 'tests': ['tp5n']}, 06:36:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:36:14 INFO - 'talos_options': ['--xperf_path', 06:36:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:14 INFO - 'tests': ['tp5n']}}, 06:36:14 INFO - 'talos.zip': {'path': '', 06:36:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:36:14 INFO - Running post-action listener: _resource_record_post_action 06:36:14 INFO - [mozharness: 2017-05-10 13:36:14.423720Z] Finished populate-webroot step (success) 06:36:14 INFO - [mozharness: 2017-05-10 13:36:14.423808Z] Running create-virtualenv step. 06:36:14 INFO - Running pre-action listener: _resource_record_pre_action 06:36:14 INFO - Running main action method: create_virtualenv 06:36:14 INFO - Creating virtualenv /builds/slave/test/build/venv 06:36:14 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 06:36:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:36:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:36:14 INFO - Using real prefix '/usr' 06:36:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:36:15 INFO - Installing distribute.............................................................................................................................................................................................done. 06:36:17 INFO - Installing pip.................done. 06:36:17 INFO - Return code: 0 06:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:36:17 INFO - Reading from file tmpfile_stdout 06:36:17 INFO - Output received: 06:36:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:36:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:36:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:17 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 0x12371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1403a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6a30>, '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 0x15a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', '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 06:36:17 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 06:36:17 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 06:36:17 INFO - Using env: {'DISPLAY': ':0', 06:36:17 INFO - 'HOME': '/home/cltbld', 06:36:17 INFO - 'LANG': 'en_US.UTF-8', 06:36:17 INFO - 'LANGUAGE': 'en_US:en', 06:36:17 INFO - 'LOGNAME': 'cltbld', 06:36:17 INFO - 'MAIL': '/var/mail/cltbld', 06:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:17 INFO - 'MOZ_NO_REMOTE': '1', 06:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:17 INFO - 'NO_EM_RESTART': '1', 06:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:17 INFO - 'PWD': '/builds/slave/test', 06:36:17 INFO - 'SHELL': '/bin/bash', 06:36:17 INFO - 'SHLVL': '1', 06:36:17 INFO - 'TERM': 'linux', 06:36:17 INFO - 'TMOUT': '86400', 06:36:17 INFO - 'USER': 'cltbld', 06:36:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', 06:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:17 INFO - '_': '/tools/buildbot/bin/python'} 06:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:17 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 06:36:17 INFO - Cleaning up... 06:36:17 INFO - Return code: 0 06:36:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:36:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:17 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1403a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6a30>, '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 0x15a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', '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 06:36:17 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>=3.1.1'] in /builds/slave/test/build 06:36:17 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>=3.1.1 06:36:17 INFO - Using env: {'DISPLAY': ':0', 06:36:17 INFO - 'HOME': '/home/cltbld', 06:36:17 INFO - 'LANG': 'en_US.UTF-8', 06:36:17 INFO - 'LANGUAGE': 'en_US:en', 06:36:17 INFO - 'LOGNAME': 'cltbld', 06:36:17 INFO - 'MAIL': '/var/mail/cltbld', 06:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:17 INFO - 'MOZ_NO_REMOTE': '1', 06:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:17 INFO - 'NO_EM_RESTART': '1', 06:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:17 INFO - 'PWD': '/builds/slave/test', 06:36:17 INFO - 'SHELL': '/bin/bash', 06:36:17 INFO - 'SHLVL': '1', 06:36:17 INFO - 'TERM': 'linux', 06:36:17 INFO - 'TMOUT': '86400', 06:36:17 INFO - 'USER': 'cltbld', 06:36:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', 06:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:17 INFO - '_': '/tools/buildbot/bin/python'} 06:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:17 INFO - Downloading/unpacking psutil>=3.1.1 06:36:17 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 06:36:17 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 06:36:17 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 06:36:17 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 06:36:17 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 06:36:17 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 06:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:36:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:18 INFO - Installing collected packages: psutil 06:36:18 INFO - Running setup.py install for psutil 06:36:18 INFO - building 'psutil._psutil_linux' extension 06:36:18 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 06:36:19 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 06:36:19 INFO - building 'psutil._psutil_posix' extension 06:36:19 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 06:36:19 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 06:36:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:19 INFO - Successfully installed psutil 06:36:19 INFO - Cleaning up... 06:36:19 INFO - Return code: 0 06:36:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:19 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1403a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6a30>, '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 0x15a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', '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 06:36:19 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.3'] in /builds/slave/test/build 06:36:19 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.3 06:36:19 INFO - Using env: {'DISPLAY': ':0', 06:36:19 INFO - 'HOME': '/home/cltbld', 06:36:19 INFO - 'LANG': 'en_US.UTF-8', 06:36:19 INFO - 'LANGUAGE': 'en_US:en', 06:36:19 INFO - 'LOGNAME': 'cltbld', 06:36:19 INFO - 'MAIL': '/var/mail/cltbld', 06:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:19 INFO - 'MOZ_NO_REMOTE': '1', 06:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:19 INFO - 'NO_EM_RESTART': '1', 06:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:19 INFO - 'PWD': '/builds/slave/test', 06:36:19 INFO - 'SHELL': '/bin/bash', 06:36:19 INFO - 'SHLVL': '1', 06:36:19 INFO - 'TERM': 'linux', 06:36:19 INFO - 'TMOUT': '86400', 06:36:19 INFO - 'USER': 'cltbld', 06:36:19 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', 06:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:19 INFO - '_': '/tools/buildbot/bin/python'} 06:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:36:19 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 06:36:19 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 06:36:19 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 06:36:19 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 06:36:19 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 06:36:19 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 06:36:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:36:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:36:20 INFO - Installing collected packages: mozsystemmonitor 06:36:20 INFO - Running setup.py install for mozsystemmonitor 06:36:20 INFO - Successfully installed mozsystemmonitor 06:36:20 INFO - Cleaning up... 06:36:20 INFO - Return code: 0 06:36:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:20 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1403a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6a30>, '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 0x15a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', '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 06:36:20 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==2.5.1'] in /builds/slave/test/build 06:36:20 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==2.5.1 06:36:20 INFO - Using env: {'DISPLAY': ':0', 06:36:20 INFO - 'HOME': '/home/cltbld', 06:36:20 INFO - 'LANG': 'en_US.UTF-8', 06:36:20 INFO - 'LANGUAGE': 'en_US:en', 06:36:20 INFO - 'LOGNAME': 'cltbld', 06:36:20 INFO - 'MAIL': '/var/mail/cltbld', 06:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:20 INFO - 'MOZ_NO_REMOTE': '1', 06:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:20 INFO - 'NO_EM_RESTART': '1', 06:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:20 INFO - 'PWD': '/builds/slave/test', 06:36:20 INFO - 'SHELL': '/bin/bash', 06:36:20 INFO - 'SHLVL': '1', 06:36:20 INFO - 'TERM': 'linux', 06:36:20 INFO - 'TMOUT': '86400', 06:36:20 INFO - 'USER': 'cltbld', 06:36:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', 06:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:20 INFO - '_': '/tools/buildbot/bin/python'} 06:36:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:21 INFO - Downloading/unpacking jsonschema==2.5.1 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:36:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:36:22 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 06:36:22 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 06:36:22 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 06:36:22 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 06:36:22 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 06:36:22 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 06:36:22 INFO - Downloading functools32-3.2.3-2.tar.gz 06:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:36:22 INFO - warning: no files found matching '*.txt' 06:36:22 INFO - no previously-included directories found matching 'build' 06:36:22 INFO - no previously-included directories found matching 'dist' 06:36:22 INFO - no previously-included directories found matching '.git*' 06:36:22 INFO - Installing collected packages: jsonschema, functools32 06:36:22 INFO - Running setup.py install for functools32 06:36:22 INFO - warning: no files found matching '*.txt' 06:36:22 INFO - no previously-included directories found matching 'build' 06:36:22 INFO - no previously-included directories found matching 'dist' 06:36:22 INFO - no previously-included directories found matching '.git*' 06:36:22 INFO - Successfully installed jsonschema functools32 06:36:22 INFO - Cleaning up... 06:36:22 INFO - Return code: 0 06:36:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:22 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1403a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6a30>, '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 0x15a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', '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 06:36:22 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:36:22 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 functools32==3.2.3-2 06:36:22 INFO - Using env: {'DISPLAY': ':0', 06:36:22 INFO - 'HOME': '/home/cltbld', 06:36:22 INFO - 'LANG': 'en_US.UTF-8', 06:36:22 INFO - 'LANGUAGE': 'en_US:en', 06:36:22 INFO - 'LOGNAME': 'cltbld', 06:36:22 INFO - 'MAIL': '/var/mail/cltbld', 06:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:22 INFO - 'MOZ_NO_REMOTE': '1', 06:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:22 INFO - 'NO_EM_RESTART': '1', 06:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:22 INFO - 'PWD': '/builds/slave/test', 06:36:22 INFO - 'SHELL': '/bin/bash', 06:36:22 INFO - 'SHLVL': '1', 06:36:22 INFO - 'TERM': 'linux', 06:36:22 INFO - 'TMOUT': '86400', 06:36:22 INFO - 'USER': 'cltbld', 06:36:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', 06:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:22 INFO - '_': '/tools/buildbot/bin/python'} 06:36:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:36:22 INFO - Cleaning up... 06:36:22 INFO - Return code: 0 06:36:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:22 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 0x12371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1403a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6a30>, '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 0x15a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', '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 06:36:22 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 06:36:22 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 06:36:22 INFO - Using env: {'DISPLAY': ':0', 06:36:22 INFO - 'HOME': '/home/cltbld', 06:36:22 INFO - 'LANG': 'en_US.UTF-8', 06:36:22 INFO - 'LANGUAGE': 'en_US:en', 06:36:22 INFO - 'LOGNAME': 'cltbld', 06:36:22 INFO - 'MAIL': '/var/mail/cltbld', 06:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:22 INFO - 'MOZ_NO_REMOTE': '1', 06:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:22 INFO - 'NO_EM_RESTART': '1', 06:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:22 INFO - 'PWD': '/builds/slave/test', 06:36:22 INFO - 'SHELL': '/bin/bash', 06:36:22 INFO - 'SHLVL': '1', 06:36:22 INFO - 'TERM': 'linux', 06:36:22 INFO - 'TMOUT': '86400', 06:36:22 INFO - 'USER': 'cltbld', 06:36:22 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', 06:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:22 INFO - '_': '/tools/buildbot/bin/python'} 06:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:23 INFO - Downloading/unpacking blobuploader==1.2.4 06:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:24 INFO - Downloading blobuploader-1.2.4.tar.gz 06:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:36:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:36:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36: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 06:36:24 INFO - Downloading docopt-0.6.1.tar.gz 06:36:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:36:24 INFO - Installing collected packages: blobuploader, requests, docopt 06:36:24 INFO - Running setup.py install for blobuploader 06:36:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:36:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:36:24 INFO - Running setup.py install for requests 06:36:25 INFO - Running setup.py install for docopt 06:36:25 INFO - Successfully installed blobuploader requests docopt 06:36:25 INFO - Cleaning up... 06:36:25 INFO - Return code: 0 06:36:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:25 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:25 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 0x12371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1403a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6a30>, '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 0x15a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', '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 06:36:25 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 06:36:25 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 06:36:25 INFO - Using env: {'DISPLAY': ':0', 06:36:25 INFO - 'HOME': '/home/cltbld', 06:36:25 INFO - 'LANG': 'en_US.UTF-8', 06:36:25 INFO - 'LANGUAGE': 'en_US:en', 06:36:25 INFO - 'LOGNAME': 'cltbld', 06:36:25 INFO - 'MAIL': '/var/mail/cltbld', 06:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:25 INFO - 'MOZ_NO_REMOTE': '1', 06:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:25 INFO - 'NO_EM_RESTART': '1', 06:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:25 INFO - 'PWD': '/builds/slave/test', 06:36:25 INFO - 'SHELL': '/bin/bash', 06:36:25 INFO - 'SHLVL': '1', 06:36:25 INFO - 'TERM': 'linux', 06:36:25 INFO - 'TMOUT': '86400', 06:36:25 INFO - 'USER': 'cltbld', 06:36:25 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', 06:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:25 INFO - '_': '/tools/buildbot/bin/python'} 06:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:25 INFO - Running setup.py (path:/tmp/pip-i7XmnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:25 INFO - Running setup.py (path:/tmp/pip-fRHilo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:25 INFO - Running setup.py (path:/tmp/pip-PoYWEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:25 INFO - Running setup.py (path:/tmp/pip-Jl0ULL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:25 INFO - Running setup.py (path:/tmp/pip-tGmITI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:26 INFO - Running setup.py (path:/tmp/pip-xqCv34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:26 INFO - Running setup.py (path:/tmp/pip-zN7Y4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:26 INFO - Running setup.py (path:/tmp/pip-8Hc13h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:26 INFO - Running setup.py (path:/tmp/pip-lkElC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:26 INFO - Running setup.py (path:/tmp/pip-0aaBlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:26 INFO - Running setup.py (path:/tmp/pip-MwyqE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:26 INFO - Running setup.py (path:/tmp/pip-ZSBfs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:26 INFO - Running setup.py (path:/tmp/pip-sF587Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:26 INFO - Running setup.py (path:/tmp/pip-eEWyRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:26 INFO - Running setup.py (path:/tmp/pip-g3z9Gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:26 INFO - Running setup.py (path:/tmp/pip-VPWe7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:26 INFO - Running setup.py (path:/tmp/pip-DFkTtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:36:26 INFO - Running setup.py install for manifestparser 06:36:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:36:26 INFO - Running setup.py install for mozcrash 06:36:27 INFO - Running setup.py install for mozdebug 06:36:27 INFO - Running setup.py install for mozdevice 06:36:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:36:27 INFO - Running setup.py install for mozfile 06:36:27 INFO - Running setup.py install for mozhttpd 06:36:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:36:27 INFO - Running setup.py install for mozinfo 06:36:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:36:27 INFO - Running setup.py install for mozInstall 06:36:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:36:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:36:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:36:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:36:27 INFO - Running setup.py install for mozleak 06:36:27 INFO - Running setup.py install for mozlog 06:36:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:36:27 INFO - Running setup.py install for moznetwork 06:36:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:36:27 INFO - Running setup.py install for mozprocess 06:36:28 INFO - Running setup.py install for mozprofile 06:36:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:36:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:36:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:36:28 INFO - Running setup.py install for mozrunner 06:36:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:36:28 INFO - Running setup.py install for mozscreenshot 06:36:28 INFO - Running setup.py install for moztest 06:36:28 INFO - Running setup.py install for mozversion 06:36:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:36:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:36:28 INFO - Cleaning up... 06:36:28 INFO - Return code: 0 06:36:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:28 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 0x12371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1403a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6a30>, '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 0x15a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', '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 06:36:28 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 06:36:28 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 06:36:28 INFO - Using env: {'DISPLAY': ':0', 06:36:28 INFO - 'HOME': '/home/cltbld', 06:36:28 INFO - 'LANG': 'en_US.UTF-8', 06:36:28 INFO - 'LANGUAGE': 'en_US:en', 06:36:28 INFO - 'LOGNAME': 'cltbld', 06:36:28 INFO - 'MAIL': '/var/mail/cltbld', 06:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:28 INFO - 'MOZ_NO_REMOTE': '1', 06:36:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:28 INFO - 'NO_EM_RESTART': '1', 06:36:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:28 INFO - 'PWD': '/builds/slave/test', 06:36:28 INFO - 'SHELL': '/bin/bash', 06:36:28 INFO - 'SHLVL': '1', 06:36:28 INFO - 'TERM': 'linux', 06:36:28 INFO - 'TMOUT': '86400', 06:36:28 INFO - 'USER': 'cltbld', 06:36:28 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', 06:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:28 INFO - '_': '/tools/buildbot/bin/python'} 06:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:28 INFO - Running setup.py (path:/tmp/pip-t8pXuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:28 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)) 06:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:28 INFO - Running setup.py (path:/tmp/pip-lxnn_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:29 INFO - Running setup.py (path:/tmp/pip-tC62pO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:29 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)) 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:29 INFO - Running setup.py (path:/tmp/pip-oLJUta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:29 INFO - Running setup.py (path:/tmp/pip-acjm2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:29 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)) 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:29 INFO - Running setup.py (path:/tmp/pip-uQzNWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:29 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)) 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:29 INFO - Running setup.py (path:/tmp/pip-JyMyZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:29 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)) 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:29 INFO - Running setup.py (path:/tmp/pip-1f2Q14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:29 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)) 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:29 INFO - Running setup.py (path:/tmp/pip-XzEA7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:29 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)) 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:29 INFO - Running setup.py (path:/tmp/pip-uZStcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:29 INFO - Running setup.py (path:/tmp/pip-3Th95a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:29 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)) 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:29 INFO - Running setup.py (path:/tmp/pip-ixj1dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:29 INFO - Running setup.py (path:/tmp/pip-ybuDrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:36:29 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)) 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:36:29 INFO - Running setup.py (path:/tmp/pip-gKq6mA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:36:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:29 INFO - Running setup.py (path:/tmp/pip-5Gb8HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:36:29 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)) 06:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:36:29 INFO - Running setup.py (path:/tmp/pip-9w6f9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 06:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:36:30 INFO - Running setup.py (path:/tmp/pip-BfMwHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:36:30 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)) 06:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:36:30 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)) 06:36:30 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:36:30 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:36:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:36:30 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 06:36:30 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 06:36:30 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 06:36:30 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 06:36:30 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 06:36:30 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 06:36:31 INFO - Downloading blessings-1.6.tar.gz 06:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:36:31 INFO - Installing collected packages: blessings 06:36:31 INFO - Running setup.py install for blessings 06:36:31 INFO - Successfully installed blessings 06:36:31 INFO - Cleaning up... 06:36:31 INFO - Return code: 0 06:36:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:36:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:31 INFO - Reading from file tmpfile_stdout 06:36:31 INFO - Current package versions: 06:36:31 INFO - argparse == 1.2.1 06:36:31 INFO - blessings == 1.6 06:36:31 INFO - blobuploader == 1.2.4 06:36:31 INFO - docopt == 0.6.1 06:36:31 INFO - functools32 == 3.2.3-2 06:36:31 INFO - jsonschema == 2.5.1 06:36:31 INFO - manifestparser == 1.1 06:36:31 INFO - mozInstall == 1.12 06:36:31 INFO - mozcrash == 1.0 06:36:31 INFO - mozdebug == 0.1 06:36:31 INFO - mozdevice == 0.50 06:36:31 INFO - mozfile == 1.2 06:36:31 INFO - mozhttpd == 0.7 06:36:31 INFO - mozinfo == 0.9 06:36:31 INFO - mozleak == 0.1 06:36:31 INFO - mozlog == 3.4 06:36:31 INFO - moznetwork == 0.27 06:36:31 INFO - mozprocess == 0.25 06:36:31 INFO - mozprofile == 0.28 06:36:31 INFO - mozrunner == 6.13 06:36:31 INFO - mozscreenshot == 0.1 06:36:31 INFO - mozsystemmonitor == 0.3 06:36:31 INFO - moztest == 0.8 06:36:31 INFO - mozversion == 1.4 06:36:31 INFO - psutil == 3.1.1 06:36:31 INFO - requests == 1.2.3 06:36:31 INFO - wsgiref == 0.1.2 06:36:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:31 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 0x12371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1403a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6a30>, '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 0x15a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', '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 06:36:31 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 06:36:31 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 06:36:31 INFO - Using env: {'DISPLAY': ':0', 06:36:31 INFO - 'HOME': '/home/cltbld', 06:36:31 INFO - 'LANG': 'en_US.UTF-8', 06:36:31 INFO - 'LANGUAGE': 'en_US:en', 06:36:31 INFO - 'LOGNAME': 'cltbld', 06:36:31 INFO - 'MAIL': '/var/mail/cltbld', 06:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:31 INFO - 'MOZ_NO_REMOTE': '1', 06:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:31 INFO - 'NO_EM_RESTART': '1', 06:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:31 INFO - 'PWD': '/builds/slave/test', 06:36:31 INFO - 'SHELL': '/bin/bash', 06:36:31 INFO - 'SHLVL': '1', 06:36:31 INFO - 'TERM': 'linux', 06:36:31 INFO - 'TMOUT': '86400', 06:36:31 INFO - 'USER': 'cltbld', 06:36:31 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', 06:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:31 INFO - '_': '/tools/buildbot/bin/python'} 06:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:31 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)) 06:36:31 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)) 06:36:31 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)) 06:36:31 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)) 06:36:31 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)) 06:36:31 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)) 06:36:31 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)) 06:36:31 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)) 06:36:31 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)) 06:36:31 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)) 06:36:31 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)) 06:36:31 INFO - Cleaning up... 06:36:31 INFO - Return code: 0 06:36:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:36:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:31 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 0x12371f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1403a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6a30>, '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 0x15a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ca0>, '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': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', '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 06:36:31 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 06:36:31 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 06:36:31 INFO - Using env: {'DISPLAY': ':0', 06:36:31 INFO - 'HOME': '/home/cltbld', 06:36:31 INFO - 'LANG': 'en_US.UTF-8', 06:36:31 INFO - 'LANGUAGE': 'en_US:en', 06:36:31 INFO - 'LOGNAME': 'cltbld', 06:36:31 INFO - 'MAIL': '/var/mail/cltbld', 06:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:31 INFO - 'MOZ_NO_REMOTE': '1', 06:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:31 INFO - 'NO_EM_RESTART': '1', 06:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:31 INFO - 'PWD': '/builds/slave/test', 06:36:31 INFO - 'SHELL': '/bin/bash', 06:36:31 INFO - 'SHLVL': '1', 06:36:31 INFO - 'TERM': 'linux', 06:36:31 INFO - 'TMOUT': '86400', 06:36:31 INFO - 'USER': 'cltbld', 06:36:31 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', 06:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:31 INFO - '_': '/tools/buildbot/bin/python'} 06:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:36:32 INFO - Cleaning up... 06:36:32 INFO - Return code: 0 06:36:32 INFO - Running post-action listener: _resource_record_post_action 06:36:32 INFO - Running post-action listener: _start_resource_monitoring 06:36:32 INFO - Starting resource monitoring. 06:36:32 INFO - [mozharness: 2017-05-10 13:36:32.168243Z] Finished create-virtualenv step (success) 06:36:32 INFO - [mozharness: 2017-05-10 13:36:32.168760Z] Running install step. 06:36:32 INFO - Running pre-action listener: _resource_record_pre_action 06:36:32 INFO - Running main action method: install 06:36:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:36:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:36:32 INFO - Reading from file tmpfile_stdout 06:36:32 INFO - Detecting whether we're running mozinstall >=1.0... 06:36:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:36:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:36:32 INFO - Reading from file tmpfile_stdout 06:36:32 INFO - Output received: 06:36:32 INFO - Usage: mozinstall [options] installer 06:36:32 INFO - Options: 06:36:32 INFO - -h, --help show this help message and exit 06:36:32 INFO - -d DEST, --destination=DEST 06:36:32 INFO - Directory to install application into. [default: 06:36:32 INFO - "/builds/slave/test"] 06:36:32 INFO - --app=APP Application being installed. [default: firefox] 06:36:32 INFO - mkdir: /builds/slave/test/build/application 06:36:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:36:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:36:48 INFO - Reading from file tmpfile_stdout 06:36:48 INFO - Output received: 06:36:48 INFO - /builds/slave/test/build/application/firefox/firefox 06:36:48 INFO - Running post-action listener: _resource_record_post_action 06:36:48 INFO - [mozharness: 2017-05-10 13:36:48.320851Z] Finished install step (success) 06:36:48 INFO - [mozharness: 2017-05-10 13:36:48.321128Z] Running run-tests step. 06:36:48 INFO - Running pre-action listener: _resource_record_pre_action 06:36:48 INFO - Running main action method: run_tests 06:36:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:36:48 INFO - Python 2.7.3 06:36:48 INFO - Return code: 0 06:36:48 INFO - grabbing minidump binary from tooltool 06:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:48 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a6a30>, '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 0x15a77f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15a7ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:36:48 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 06:36:48 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 06:36:48 INFO - Calling ['/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'] with output_timeout 600 06:36:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:36:48 INFO - Return code: 0 06:36:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:36:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:36:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:36:48 INFO - ENV: RUST_BACKTRACE is now 1 06:36:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:36:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:36:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:36:48 INFO - Using env: {'DISPLAY': ':0', 06:36:48 INFO - 'HOME': '/home/cltbld', 06:36:48 INFO - 'LANG': 'en_US.UTF-8', 06:36:48 INFO - 'LANGUAGE': 'en_US:en', 06:36:48 INFO - 'LOGNAME': 'cltbld', 06:36:48 INFO - 'MAIL': '/var/mail/cltbld', 06:36:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:36:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:48 INFO - 'MOZ_NO_REMOTE': '1', 06:36:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:48 INFO - 'NO_EM_RESTART': '1', 06:36:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:48 INFO - 'PWD': '/builds/slave/test', 06:36:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:36:48 INFO - 'RUST_BACKTRACE': '1', 06:36:48 INFO - 'SHELL': '/bin/bash', 06:36:48 INFO - 'SHLVL': '1', 06:36:48 INFO - 'TERM': 'linux', 06:36:48 INFO - 'TMOUT': '86400', 06:36:48 INFO - 'USER': 'cltbld', 06:36:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796', 06:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:48 INFO - '_': '/tools/buildbot/bin/python'} 06:36:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:36:48 INFO - mozversion application_buildid: 20170510130637 06:36:48 INFO - mozversion application_changeset: 8ad5338081026c48029d72f1e6c1668a58489bec 06:36:48 INFO - mozversion application_display_name: Nightly 06:36:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:36:48 INFO - mozversion application_name: Firefox 06:36:48 INFO - mozversion application_remotingname: firefox 06:36:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:36:48 INFO - mozversion application_vendor: Mozilla 06:36:48 INFO - mozversion application_version: 55.0a1 06:36:48 INFO - mozversion platform_buildid: 20170510130637 06:36:48 INFO - mozversion platform_changeset: 8ad5338081026c48029d72f1e6c1668a58489bec 06:36:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:36:48 INFO - mozversion platform_version: 55.0a1 06:36:48 INFO - using testdate: 1494423408 06:36:48 INFO - actual date: 1494423408 06:36:48 INFO - starting webserver on 'localhost:38392' 06:36:48 INFO - SUITE-START | Running 2 tests 06:36:48 INFO - TEST-START | dromaeo_css 06:36:48 INFO - operating with platform_type : linux_ 06:36:48 INFO - Initialising browser for dromaeo_css test... 06:36:48 INFO - TEST-INFO | started process 305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6IMwOn/profile http://localhost:38392/getInfo.html) 06:36:52 INFO - PID 305 | __metrics Screen width/height:1600/1200 06:36:52 INFO - PID 305 | colorDepth:24 06:36:52 INFO - PID 305 | Browser inner width/height: 1024/695 06:36:52 INFO - PID 305 | __metrics 06:36:52 INFO - PID 305 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:36:52 INFO - PID 305 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:36:54 INFO - TEST-INFO | 305: exit 0 06:36:54 INFO - Browser initialized. 06:36:54 INFO - Running cycle 1/1 for dromaeo_css test... 06:36:54 INFO - TEST-INFO | started process 400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6IMwOn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:05 INFO - PID 400 | RSS: Main: 149315584 06:37:05 INFO - PID 400 | 06:40:12 INFO - PID 400 | Cycle 1(1): loaded http://localhost:38392/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38392/tests/dromaeo/cssquery-ext.html) 06:40:14 INFO - PID 400 | RSS: Main: 285773824 06:40:14 INFO - PID 400 | 06:43:16 INFO - PID 400 | Cycle 1(1): loaded http://localhost:38392/tests/dromaeo/cssquery-ext.html (next: http://localhost:38392/tests/dromaeo/cssquery-jquery.html) 06:43:17 INFO - PID 400 | RSS: Main: 227663872 06:43:17 INFO - PID 400 | 06:46:18 INFO - PID 400 | Cycle 1(1): loaded http://localhost:38392/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38392/tests/dromaeo/cssquery-mootools.html) 06:46:19 INFO - PID 400 | RSS: Main: 182923264 06:46:19 INFO - PID 400 | 06:49:21 INFO - PID 400 | Cycle 1(1): loaded http://localhost:38392/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38392/tests/dromaeo/cssquery-prototype.html) 06:49:22 INFO - PID 400 | RSS: Main: 178610176 06:49:22 INFO - PID 400 | 06:52:25 INFO - PID 400 | Cycle 1(1): loaded http://localhost:38392/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38392/tests/dromaeo/cssquery-yui.html) 06:52:26 INFO - PID 400 | RSS: Main: 176537600 06:52:26 INFO - PID 400 | 06:55:28 INFO - PID 400 | Cycle 1(1): loaded http://localhost:38392/tests/dromaeo/cssquery-yui.html (next: http://localhost:38392/tests/dromaeo/cssquery-dojo.html) 06:55:28 INFO - PID 400 | RSS: Main: 269967360 06:55:28 INFO - PID 400 | 06:55:28 INFO - PID 400 | __start_tp_report 06:55:28 INFO - PID 400 | _x_x_mozilla_page_load 06:55:28 INFO - PID 400 | _x_x_mozilla_page_load_details 06:55:28 INFO - PID 400 | |i|pagename|runs| 06:55:28 INFO - PID 400 | |0;dojo.html;2704.7565719085283;2708.7832973362133;2738.4386200828826;2748.7251274872515;2748.793840461966;5122.052420302238;5243.554297884684;5259.421463639002;5290.0477913975465;5308.575313974878;5192.610554208431;5194.194899790529;5202.843914682556;5216.478352164781;5224.92162617561;4626.028534007863;4651.488336283006;4656.790444430008;4682.642033810191;4697.271922851964;4687.6952998055185;4708.529147085281;4719.386479757627;4727.479977202505;4734.644901632374;4700.858974230779;4709.929351059737;4713.43438787346;4713.740744259065;4714.811407543694;4704.059188162381;4706.294055891643;4708.529147085298;4708.952910470885;4710.152172608929;4581.725096494221;4612.238980568202;4661.650376221797;4681.625469962395;4710.29345598163;5196.506331898464;5213.635045546814;5236.554892834114;5250.7637156328055;5309.469053094698;5603.719814009283;5620.325560932714;5628.0713682242385;5646.124850648156;5688.033034384164;5085.415177254589;5529.695866727328;5532.7786888524415;5564.888702225973;5568.832935011957;5253.395859476209;5269.262303277545;5306.124489459196;5308.177232528964;5312.574994000471;5798.623089499169;5808.506276966421;5812.534997200214;5822.388649191774;5834.970825145847;5430.049741295336;5522.6134170608475;5525.226468294442;5541.722913854291;5548.250986116904;5532.197831314517;5547.25112109868;5608.971955140199;5638.323401191883;5649.830505084854;5564.248826408383;5595.664260144405;5604.3835178130375;5604.97197514018;5606.635568688022;5529.889402212014;5539.058360078716;5586.748596313095;5596.048671725816;5601.5238704710555;4501.572350626685;4546.249868771682;4555.202839503074;4615.676902616851;4626.514216007338;3940.2907476653904;3977.8607748728655;3981.6018398159954;3985.501812273466;4025.355943049098;4764.714117152982;4807.894184337552;4815.831445899446;4833.661643684979;4859.198232291632;5558;5564.026295398289;5625.662460252316;5627.8593035174445;5698.430156984351;4770.95229047712;4811.591014763714;4812;4814.807407703723;4818.4217893852965;4993.300937868701;4998.025385049953;5001.299818025479;5005.74971251436;5007.9499205008215;5208.843734688041;5228.816991405282;5229.764660590206;5230.660007099526;5232.581393488588;5609.971950140223;5649.209110724584;5652.378238393856;5655.519280861008;5657.8019769307875;5222.686638801684;5228.085085110014;5231.738413079407;5234.11020126587;5235.4764523548865;5541.584381171348;5545.556355491632;5553.6390134641115;5559.4162612926675;5564.693941833076;5598.384177740527;5608.579356548356;5608.831735047955;5616.887662246814;5675;5400.675959442446;5469.808556700496;5488.4237155098135;5489.505944465017;5543.279373681396;5408.567314614743;5466.808661696821;5467.781288748405;5495.368032676293;5520.861978450571;5402.6758394496455;5430.104032834538;5432.945670543402;5434.239206511171;5436.537894278872;5425.945740542702;5535.363433205233;5539.086050801573;5551.195076713934;5607.130894711327;5315.096433606219;5315.840524784263;5378.193271009223;5378.7579558920725;5435.456454354533 06:55:28 INFO - PID 400 | |1;ext.html;660.3594513322079;714.4355958792553;722.3101937649543;923.870658107865;942.1897168435149;24003.399915002134;32019.19952001198;32605.510917336258;32684.182895427628;32684.509732354032;34380.65619343806;34839;34869.12827179322;34871.82564087176;34894.82552587234;5383.327084114486;5526.751296191661;6989.231184569693;7161.606111663857;7165.319294666998;6383.776567820128;7101.644917754117;7122.9287707122785;7123.074000379944;7128.6079265640365;7114.146302443688;7213.458990575701;7222.530535515201;7232.746853860116;7240.746573869916;7171.820704482404;7175.569465832067;7230.674619642129;7233.565986040854;7233.927660723431;6977.755778547727;7030.578165310098;7043.190033146203;7048.541844780073;7051.365377116084;32267.51598726021;32464.837675811705;32479.675203248138;32484.18789530257;32501.674983250337;3071;3073.0319949215927;3096.9535456968165;3106;3111.6110486189227;24120;24229;24262.757372426226;24290.271291861096;24332;3188.0595224408853;3207.3104282579125;3226.9031929042167;3229.11199420159;3240;139014.99999999898;139461;139479;139763;139855;40742.388864167064;40809;40851.38722919158;40904.38643420351;40940.79529602333;42117.78941105336;42139.15721685549;42185;42200.57799421967;42255.7887210562;12609.180403273758;12681.873181268069;12682.49270029207;12719.427625756864;12735.23588584688;8023.759287221393;8143.348532117417;10194.643187488402;10207.693769186937;10248.38509689406;10855.348679079281;10952.288101273392;10955.287906286067;11992.580259690869;12233.816492752616;4821.960276465605;4870.788662939236;4919.877003074952;4968.652194346361;4997.675151115166;887.2680038967877;888.0941439731438;904.0959040959041;908.3641450984205;913.9725808225763;20678.379648610568;20827.8958605206;21071.578568428544;21167;21396.144154233967;978.3787295067683;980.4313498171043;995.6017592962872;1005.5927349423495;1007.6573964851985;10501.422421766876;11191.888081119085;11243.156763242789;11255.099592032619;11338.206325557298;161839.19080404524;161842;161994.4703594286;162080;162189.18905405398;39896.40155397671;40034.79982600127;40081.39877901834;40207.798961005596;40211;1208.528673817212;1232.5439587352557;1236.771197328497;1239.659093749208;1251.1992324912064;19721.211151553776;19729.506762331057;20206.29277975264;20965.475863103544;21250.89374553117;29153.85423072871;29189.270268243465;29202.123936281947;29215.393153376768;29229.415411692073;150516;150518.49481505482;150682.24658877074;151070;151350.24324878305;28794.42411151807;29105.563416549194;29244.56133158047;29332.70667293385;29411;29569;30220;34370.484442733876;34707;36015.459768104025;25495;25815.483690325713;25816.741832581432;26265.4746905057;27483.17550473489;26698.86650566735;26825.86587067052;27003.459930801666;27189;27513.31216719598;29173.7082629171;29284.414311714074;29322.120336389944;29335.413291734472;29376.55935161017;24877.626835597843;25935.09227177115;25984.8700756495;34612.480812787326;35119.47320790241;25896.741032589434;25916.740832591433;27151;27842.860785695942;28864.42271154523 06:55:28 INFO - PID 400 | |2;jquery.html;393.9231849789292;395.3950455802623;412.04611324783133;416.8061851239173;431.34220314021115;16050.759238611401;17046.82953170468;17536.912315438436;17674.64650706987;17681;17604.735928961043;18017.459476215703;18161.63676726468;18266.269349226048;18425.631487370243;5159.174532074869;5175.068487672236;5314.388845282784;5397.298351214336;5404.945950540484;5235.293235413227;5325.840224793263;5332.680039197641;5333.946660533384;5334.813281535147;5140.997505486432;5195.532402083812;5310.07073762092;5320.973395133019;5326.334208223972;5261.789528418878;5299.576033917316;5308.150695888678;5308.92036619451;5313.362396512443;4574.153781550423;4719.07977944301;4752.310914917318;4767.880802979953;4771.188897887333;20905.163793448242;20959.16163353464;20963.371098866905;21123.15507379703;21136.577268454697;1632.3633782824709;1661.567992321993;1662.8087769906494;1662.8919120257144;1664.6171380582414;13816.516421925184;14325.140491570435;14624.976251662389;14680.504314266493;14916.552503424915;2038.5311378382908;2045.2228153301799;2095.8008989146006;2103.4846462616606;2118.9046492907855;78533.60733196298;79285;79987.60006199931;80396.59801701012;82426.17573824245;10103.393796372242;10137.290389672653;10249.84625230622;10389.467581022489;10395.272330936914;14220.146791192561;14295.07082039664;14347.139171649735;14351.138931664134;14380.280985950661;7006.894896576556;7226.747063852845;7267.30960558746;7357.852842943111;7408.518446300973;6727.495437842182;6752.831179220559;6907.378335949788;6927.826804329932;6939.757108501179;6489.3510648934725;6642.767503137367;6646.468282537386;6675.46596272297;6755.7973260802255;1773.485689150132;1792.2203841329062;1807.168702396886;1817.0732926207465;1844.0963927675343;873.7553485024204;887.2680038967749;891.2424439226735;896.8834051573384;900.2842740021698;16148.596285092732;16389;16467.58831029234;16568.254428550743;17291.308347666203;880.4365206267994;893.4091135706503;901.5221932375852;908.7364664247426;919.4253591505309;8733.81215856208;9025.63897444108;9130.497822619687;9433.39632262517;9512.28657850664;320609;338397;338787;339145;339902;73262.63368683122;74782.62608687031;76294.61852690701;76434.61782691051;80155;1056.5826498533036;1073;1077.127526703357;1083.7019819549687;1085.4247248958065;14174;14183.361748721127;14301.92849035748;14306.928465357607;14673.853261467675;38016.239675206896;38360.86226203794;38439;38837.6116238834;39403;46091.539084608725;46181.30728039015;46305.53694463012;46358.30462543132;48993.020139596294;7597.354224890946;7599.582022988789;7810.531368117931;7842.803929901798;7843.548943445481;11601.825972610586;12235.510579577074;12435.37823108859;12679.429425675682;12716.682082948;10340.844887326546;10381;10533.315334503233;10898.291611045257;10949.56201751921;9428;9718.854217186888;9863.112319891245;9901.158401535662;9922.107010369102;10625.043746062891;10671;10910.345379277269;11083.224174307721;11112.666620001413;7668.616569171408;7685.577293248925;7809.609519524115;7895.052593688794;7961.761147165595;10777.784444311226;11009.504572294105;11010.944945275543;11267.718307042389;11403.714907127389 06:55:28 INFO - PID 400 | |3;mootools.html;1137.4710759496832;1257.50328620195;1299.8115273285373;1314.986850131499;1330.4212667489642;8612.354073444494;9707.271954603397;10235.846462303061;10284.023017813295;10286.691399258016;10044.899551004488;10148.49257537122;10161.136303414218;10165.339252948554;10183.694489165337;1887.5375532994435;2252.5157091225424;2301.3211102724654;2301.7698230177016;2301.850379725321;1942.5435022769639;2211.181862710799;2296.150424342987;2300.9424764380856;2310.6765052892524;2232.162938897913;2244.382794731454;2255.4474153832252;2256.8533045352;2257.841951063426;2105.705201271823;2111.123883588309;2112.915483380663;2115.714378558898;2119.2900378373265;2157.46063484129;2171.5873983943;2178.575177840322;2179.7929196726445;2180.563887222562;9995.300328976975;10023.799524009552;10065.597376104946;10087.445190514518;10091.798164036678;5660.320761508646;5888.5877988540815;5895.322037965646;5897.351291357947;5898.439648233411;3145.905622831319;3330.2673411849355;3391.1522119470133;3394.8642054317797;3395.5416018837386;1080.6541906589894;1083.1767856429092;1118.6644006797928;1144.5307423956222;1149.5976408257127;14741.631459213499;14763.26183690822;14774.556763297118;14775.335109920079;14855.554333370017;5084.8220312288895;5088.236764485357;5218.817341393033;5390.838274851761;5398.62209645321;12544.184627999151;12570.434330455151;12570.560030398892;12571.74856502883;12593.559225427067;5882.588218824641;5898.852528686817;5906.173135760997;5911.881762364728;5916.5858389913155;5281.656692314988;5352.785888564414;5368.114261146867;5371.704556249366;5394.379646340721;4212.199682060399;4269.124829410026;4338.197433474817;4344.3049112142535;4363.454568178978;1343.3350491506767;1365.7336819320335;1367.3915107776943;1379.1793882639813;1388.5834249725042;661.7319985405918;690.730615060127;692.504859025799;705.7988473285089;713.165596252386;5445.754941027663;5532.778688852401;5535.667859928417;5629.746661400247;5700.8004719835435;551.7020808763303;561.8201776269882;566.8752874367633;567.0473604344658;569.5728203847115;3101.705337992887;3119.625644922624;3193.377291428196;3196.568463257477;3213.4697774867354;12575.811362829565;13404.128731632412;13512.121712088683;13542.932285338511;13550.035244889435;13242.602721918358;13257.138286011379;13409.262490562918;13410.530631428048;13488.190708557519;7652.354743730125;7765.495242809199;7891.408144389194;7905.169957154531;7994.84010319802;5649.350324712546;5710.3433105193435;5760.366359700346;5797.8550536236935;5906.557008224315;11766.941165294118;11821.231619944676;11906.166568340133;11935.52257909674;11967.700807479883;11248.887511124783;12272.570460033856;12362.75274494523;12473.563425280072;12476.251424914533;7307.598082105323;7777.716676748273;7843.450958432855;7844.333231675143;7972.960135199287;9568.043195680377;9646;9675.467849268358;9705.708828735149;9839.409635421898;8214.219649133323;8255.298299644357;8283;8315.542645154575;8434.493930364199;7967.28294453502;7969;7986.241307075818;8185.976752905886;8194.22154895284;7655.46411751172;7665.770026899202;7718.112417072109;7748.690052397841;7787.260210280015;4968.701877887338;5118.257852611276;5126.512981266774;5139.511746384088;5144.614153938394;4938.851834444972;4971.726555039363;4996.975015125046;5016.673916195436;5055.393352797688 06:55:28 INFO - PID 400 | |4;prototype.html;381.70608631353844;384.2257850431381;386.0503162220936;388.81336958260033;392.5720964149077;5316.5215130638235;5328.973355133224;5342.439043900393;5353.785848566057;5356.223347614594;5173.896522069556;5195.532402083812;5237.742941693995;5257.395399529055;5260.736963151837;4149.751014939098;4159.126583417471;4160.209560183571;4173.290540608089;4176.227397931377;4163.333866581347;4165.520965089008;4171.103212809246;4172.18509948172;4175.979120104395;4061.1268577255883;4146.834126634931;4153.8161623937185;4155.667546596265;4165.6250937415625;4112.943528235882;4129.359949207847;4136.338185890243;4136.379543068534;4155.501339839208;3717.2937141943216;3731.365667836474;3736.3461394255896;3737.3272810894027;3742.1954279829697;4984.551390374847;5121;5159.406668233164;5169.276301317818;5176.249443830661;4803.255495398219;4813.3983252093485;4856.732879691615;4859.34398856157;4867.415910090776;5530.557555395559;5533.418991005927;5547.44525547446;5559.33288005442;5577.665340079568;4102.118044620421;4182.163567286555;4187.539370669224;4193.454850869368;4196.160767846412;5637.379888212294;5760.798372056958;5768.625039372428;5782.421757824268;5800.854978625526;4314;4385.451818522684;4397.31841564558;4416.24923762961;4424.336349547593;4504.3919070925;4514.210013247734;4514.616257618073;4516.299973504112;4533.9319910201375;4651.651126165483;4652.534746525388;4904.493287299527;4976.825811096594;4977.427595826526;5579.69311687861;5617.41017193197;5641.661500309912;5670.603057785916;5677.460641239076;1553.2932515705327;1565.6164239761104;1568.317781764936;1568.4196847166393;1570.3404570080593;1111.9833202501968;1117.6870476266658;1119.2948442481186;1119.9552017919193;1121.6354684727496;4871.756412179377;4876.414830220397;4909.828156014522;4911.631627627942;4912.164931961575;5827.619980411436;5844.327902291291;5844.8538786529825;5847.415258474203;5849.151872978395;4781.545753153445;4888.875558621537;4898.53463920927;4919.827806026772;4923.8276660316715;3048.6189226346705;3072.6005619269354;3077.861496232675;3079.9538006929915;3114.8131112133347;5333.946660533423;5422.8373148805595;5425.5856144016325;5430.15832545956;5447.455254474521;5926.407359264039;5938.554608404387;5944.768603628779;5955.255593050869;5964.314103878023;5392.703401312965;5402.972985135128;5412.134058550613;5420.9186862197885;5435.483629055233;5666.716664166857;5761.279840019997;5782.739776710142;5801.854953626024;5839.240898683144;5683.261176047087;5720.313562372542;5729.512991395778;5735.311762588516;5754.827355179351;5148.510891465305;5257.342832145981;5291.1798671206025;5376.919346209888;5400.891982160413;4438.800253988643;4450.666200035075;4460.1971645104195;4463.799129039266;4465.933011004772;5704.714764261853;5814.970925145347;5845.736941837543;5850.7074646266665;5886.676232807236;5576.219329293821;5582.330120385417;5615.157726341082;5628.352739434854;5629.268195134607;5625.437456254342;5631.352394474688;5635.154726791015;5641.717914104361;5654.378018417889;5387.191921211849;5515.944840551543;5524.4199359066715;5545.445455454584;5565.193047008081;5642.633228840113;5647.7176141193595;5648;5651.547876169814;5658.773649053992;5464.3442786865835;5484.698341591251;5512.91730624033;5522.392536820867;5530.6128570999645 06:55:28 INFO - PID 400 | |5;yui.html;625.2153547298141;627.5293529852611;631.9602710960281;647.3461803578385;655.6361219523163;11942.522299108035;12203.633890983263;12237.571684991039;12249.938750306235;12259.754804903896;14970.850291497081;16255.837441625581;16302;16341.509754707378;16345;875.0593112404159;898.9820203595924;900.1403659505189;909.3089252168334;909.8953620333647;897.1208215948375;898.4115404410122;899.7750562359411;900.1178844732134;900.3247564326755;944.7496413450441;945.1824172091126;945.4469135555709;945.8864936207631;946.1673727120125;932.0260327957301;932.7947851472666;932.8087742012905;933.785229397239;935.7567032571546;647.744141064277;662.6454846657016;694.6735034533812;695.4679670052413;695.6521739130435;13533.526326578523;13648.249346285951;13670.93164534171;13711;13770.793438098437;13616.38726257311;14306.499272525516;14647.92676036613;14695.33870975798;14717.779233311509;11233.66299011031;11337.603183888525;11419.200655954086;11458.312501249951;11462.083033357394;2840.5029119904143;2861.141657502741;2862.5563037729185;2863.9284017899718;2865.498537755905;75230.46773451721;75835.62082189554;75870.62064689696;75945.62027189828;77572.61213693951;12446.937765311115;12588.4335204916;12597.559085431965;12601.621951341474;12616.74766504683;17334.566635834206;17782.466526004242;17962.64074718498;18006.369777058004;22006.339809805733;5210.739463026834;5739.110437882135;6470.1588793457495;6548.639824809586;6568.244651865001;3035.7874948753374;3101.2246938265434;3106.378724255158;3106.5650808886776;3111.642161151451;3241.9837900810817;3318.5519954806273;3320.1533608929567;3334.699877011032;3387.3733359328603;755.2938002967243;768.1933969332179;773.5126870071819;776.7863837444635;781.2265856801725;503.17730510615405;510.1124044163204;510.4232217594095;512.5489569179173;515.4613428966738;8380.664773409117;8852.468851868909;9027.864582031274;9061.229795467327;9254.768630784285;503.413523245415;503.45878180955617;511.97696103675423;514.8892988007597;522.4148953172471;4162.772916489664;4165.66674666026;4203.642690371353;4207.726497777696;4209.852655157116;60830.69435978292;62282;63377.36622633807;64085;65277;56317.71841140768;56775.43224567784;57218.42781572214;57346;59445.70277148586;51838.740806295726;52252.47747522476;52343.73828130835;52393;52589.47410525922;8321.500709957421;8375.539345336065;8423.284020858051;8522.190391912758;8570.871436928326;20165.49586260355;25933.740662593886;26591.867040664674;27294;27558.173254802387;46625.53374466212;46669.76665116653;47027.76486117548;47057;47061;13664.65838354049;13847.653808654864;13948.860511394756;14089.929550352183;14092.084014539432;14711.632209194855;14795.630109247355;14969.77545336799;14999.325030373877;15139.772903406238;12644.367781611067;12719.682007949876;12810.87189128134;12820.61538153857;12903.161294515827;13047.412866420844;13118;13127.606171814861;13333.799993000306;13408.195508269535;13837.308134593432;14086.36611352512;14151.575452736435;14235.928820355832;14425.42298308056;9216.907830921606;9434.339596228197;9542.809143817223;9674.951625241829;9724.75688107803;11219.439028048728;11455.942720286344;11524.711882203012;11823.467943942715;11958.342291173722 06:55:28 INFO - PID 400 | __end_tp_report 06:55:28 INFO - PID 400 | __start_cc_report 06:55:28 INFO - PID 400 | _x_x_mozilla_cycle_collect,1436 06:55:28 INFO - PID 400 | __end_cc_report 06:55:28 INFO - PID 400 | __startTimestamp1494424528437__endTimestamp 06:55:28 INFO - PID 400 | 06:55:28 INFO - PID 400 | ------- Summary: start ------- 06:55:28 INFO - PID 400 | Number of tests: 6 06:55:28 INFO - PID 400 | 06:55:28 INFO - PID 400 | [#0] dojo.html Cycles:165 Average:5141.85 Median:5308.18 stddev:599.79 (11.3%) stddev-sans-first:570.34 06:55:28 INFO - PID 400 | Values: 2704.8 2708.8 2738.4 2748.7 2748.8 5122.1 5243.6 5259.4 5290.0 5308.6 5192.6 5194.2 5202.8 5216.5 5224.9 4626.0 4651.5 4656.8 4682.6 4697.3 4687.7 4708.5 4719.4 4727.5 4734.6 4700.9 4709.9 4713.4 4713.7 4714.8 4704.1 4706.3 4708.5 4709.0 4710.2 4581.7 4612.2 4661.7 4681.6 4710.3 5196.5 5213.6 5236.6 5250.8 5309.5 5603.7 5620.3 5628.1 5646.1 5688.0 5085.4 5529.7 5532.8 5564.9 5568.8 5253.4 5269.3 5306.1 5308.2 5312.6 5798.6 5808.5 5812.5 5822.4 5835.0 5430.0 5522.6 5525.2 5541.7 5548.3 5532.2 5547.3 5609.0 5638.3 5649.8 5564.2 5595.7 5604.4 5605.0 5606.6 5529.9 5539.1 5586.7 5596.0 5601.5 4501.6 4546.2 4555.2 4615.7 4626.5 3940.3 3977.9 3981.6 3985.5 4025.4 4764.7 4807.9 4815.8 4833.7 4859.2 5558.0 5564.0 5625.7 5627.9 5698.4 4771.0 4811.6 4812.0 4814.8 4818.4 4993.3 4998.0 5001.3 5005.7 5007.9 5208.8 5228.8 5229.8 5230.7 5232.6 5610.0 5649.2 5652.4 5655.5 5657.8 5222.7 5228.1 5231.7 5234.1 5235.5 5541.6 5545.6 5553.6 5559.4 5564.7 5598.4 5608.6 5608.8 5616.9 5675.0 5400.7 5469.8 5488.4 5489.5 5543.3 5408.6 5466.8 5467.8 5495.4 5520.9 5402.7 5430.1 5432.9 5434.2 5436.5 5425.9 5535.4 5539.1 5551.2 5607.1 5315.1 5315.8 5378.2 5378.8 5435.5 06:55:28 INFO - PID 400 | 06:55:28 INFO - PID 400 | [#1] ext.html Cycles:180 Average:29554.96 Median:16645.50 stddev:38915.66 (233.8%) stddev-sans-first:38964.34 06:55:28 INFO - PID 400 | Values: 660.4 714.4 722.3 923.9 942.2 24003.4 32019.2 32605.5 32684.2 32684.5 34380.7 34839.0 34869.1 34871.8 34894.8 5383.3 5526.8 6989.2 7161.6 7165.3 6383.8 7101.6 7122.9 7123.1 7128.6 7114.1 7213.5 7222.5 7232.7 7240.7 7171.8 7175.6 7230.7 7233.6 7233.9 6977.8 7030.6 7043.2 7048.5 7051.4 32267.5 32464.8 32479.7 32484.2 32501.7 3071.0 3073.0 3097.0 3106.0 3111.6 24120.0 24229.0 24262.8 24290.3 24332.0 3188.1 3207.3 3226.9 3229.1 3240.0 139015.0 139461.0 139479.0 139763.0 139855.0 40742.4 40809.0 40851.4 40904.4 40940.8 42117.8 42139.2 42185.0 42200.6 42255.8 12609.2 12681.9 12682.5 12719.4 12735.2 8023.8 8143.3 10194.6 10207.7 10248.4 10855.3 10952.3 10955.3 11992.6 12233.8 4822.0 4870.8 4919.9 4968.7 4997.7 887.3 888.1 904.1 908.4 914.0 20678.4 20827.9 21071.6 21167.0 21396.1 978.4 980.4 995.6 1005.6 1007.7 10501.4 11191.9 11243.2 11255.1 11338.2 161839.2 161842.0 161994.5 162080.0 162189.2 39896.4 40034.8 40081.4 40207.8 40211.0 1208.5 1232.5 1236.8 1239.7 1251.2 19721.2 19729.5 20206.3 20965.5 21250.9 29153.9 29189.3 29202.1 29215.4 29229.4 150516.0 150518.5 150682.2 151070.0 151350.2 28794.4 29105.6 29244.6 29332.7 29411.0 29569.0 30220.0 34370.5 34707.0 36015.5 25495.0 25815.5 25816.7 26265.5 27483.2 26698.9 26825.9 27003.5 27189.0 27513.3 29173.7 29284.4 29322.1 29335.4 29376.6 24877.6 25935.1 25984.9 34612.5 35119.5 25896.7 25916.7 27151.0 27842.9 28864.4 06:55:28 INFO - PID 400 | 06:55:28 INFO - PID 400 | [#2] jquery.html Cycles:180 Average:23282.88 Median:19899.20 stddev:55954.72 (281.2%) stddev-sans-first:56085.29 06:55:28 INFO - PID 400 | Values: 393.9 395.4 412.0 416.8 431.3 16050.8 17046.8 17536.9 17674.6 17681.0 17604.7 18017.5 18161.6 18266.3 18425.6 5159.2 5175.1 5314.4 5397.3 5404.9 5235.3 5325.8 5332.7 5333.9 5334.8 5141.0 5195.5 5310.1 5321.0 5326.3 5261.8 5299.6 5308.2 5308.9 5313.4 4574.2 4719.1 4752.3 4767.9 4771.2 20905.2 20959.2 20963.4 21123.2 21136.6 1632.4 1661.6 1662.8 1662.9 1664.6 13816.5 14325.1 14625.0 14680.5 14916.6 2038.5 2045.2 2095.8 2103.5 2118.9 78533.6 79285.0 79987.6 80396.6 82426.2 10103.4 10137.3 10249.8 10389.5 10395.3 14220.1 14295.1 14347.1 14351.1 14380.3 7006.9 7226.7 7267.3 7357.9 7408.5 6727.5 6752.8 6907.4 6927.8 6939.8 6489.4 6642.8 6646.5 6675.5 6755.8 1773.5 1792.2 1807.2 1817.1 1844.1 873.8 887.3 891.2 896.9 900.3 16148.6 16389.0 16467.6 16568.3 17291.3 880.4 893.4 901.5 908.7 919.4 8733.8 9025.6 9130.5 9433.4 9512.3 320609.0 338397.0 338787.0 339145.0 339902.0 73262.6 74782.6 76294.6 76434.6 80155.0 1056.6 1073.0 1077.1 1083.7 1085.4 14174.0 14183.4 14301.9 14306.9 14673.9 38016.2 38360.9 38439.0 38837.6 39403.0 46091.5 46181.3 46305.5 46358.3 48993.0 7597.4 7599.6 7810.5 7842.8 7843.5 11601.8 12235.5 12435.4 12679.4 12716.7 10340.8 10381.0 10533.3 10898.3 10949.6 9428.0 9718.9 9863.1 9901.2 9922.1 10625.0 10671.0 10910.3 11083.2 11112.7 7668.6 7685.6 7809.6 7895.1 7961.8 10777.8 11009.5 11010.9 11267.7 11403.7 06:55:28 INFO - PID 400 | 06:55:28 INFO - PID 400 | [#3] mootools.html Cycles:180 Average:6333.00 Median:3395.20 stddev:4085.13 (120.3%) stddev-sans-first:4077.94 06:55:28 INFO - PID 400 | Values: 1137.5 1257.5 1299.8 1315.0 1330.4 8612.4 9707.3 10235.8 10284.0 10286.7 10044.9 10148.5 10161.1 10165.3 10183.7 1887.5 2252.5 2301.3 2301.8 2301.9 1942.5 2211.2 2296.2 2300.9 2310.7 2232.2 2244.4 2255.4 2256.9 2257.8 2105.7 2111.1 2112.9 2115.7 2119.3 2157.5 2171.6 2178.6 2179.8 2180.6 9995.3 10023.8 10065.6 10087.4 10091.8 5660.3 5888.6 5895.3 5897.4 5898.4 3145.9 3330.3 3391.2 3394.9 3395.5 1080.7 1083.2 1118.7 1144.5 1149.6 14741.6 14763.3 14774.6 14775.3 14855.6 5084.8 5088.2 5218.8 5390.8 5398.6 12544.2 12570.4 12570.6 12571.7 12593.6 5882.6 5898.9 5906.2 5911.9 5916.6 5281.7 5352.8 5368.1 5371.7 5394.4 4212.2 4269.1 4338.2 4344.3 4363.5 1343.3 1365.7 1367.4 1379.2 1388.6 661.7 690.7 692.5 705.8 713.2 5445.8 5532.8 5535.7 5629.7 5700.8 551.7 561.8 566.9 567.0 569.6 3101.7 3119.6 3193.4 3196.6 3213.5 12575.8 13404.1 13512.1 13542.9 13550.0 13242.6 13257.1 13409.3 13410.5 13488.2 7652.4 7765.5 7891.4 7905.2 7994.8 5649.4 5710.3 5760.4 5797.9 5906.6 11766.9 11821.2 11906.2 11935.5 11967.7 11248.9 12272.6 12362.8 12473.6 12476.3 7307.6 7777.7 7843.5 7844.3 7973.0 9568.0 9646.0 9675.5 9705.7 9839.4 8214.2 8255.3 8283.0 8315.5 8434.5 7967.3 7969.0 7986.2 8186.0 8194.2 7655.5 7665.8 7718.1 7748.7 7787.3 4968.7 5118.3 5126.5 5139.5 5144.6 4938.9 4971.7 4997.0 5016.7 5055.4 06:55:28 INFO - PID 400 | 06:55:28 INFO - PID 400 | [#4] prototype.html Cycles:180 Average:4700.60 Median:5175.07 stddev:1314.09 (25.4%) stddev-sans-first:1277.16 06:55:28 INFO - PID 400 | Values: 381.7 384.2 386.1 388.8 392.6 5316.5 5329.0 5342.4 5353.8 5356.2 5173.9 5195.5 5237.7 5257.4 5260.7 4149.8 4159.1 4160.2 4173.3 4176.2 4163.3 4165.5 4171.1 4172.2 4176.0 4061.1 4146.8 4153.8 4155.7 4165.6 4112.9 4129.4 4136.3 4136.4 4155.5 3717.3 3731.4 3736.3 3737.3 3742.2 4984.6 5121.0 5159.4 5169.3 5176.2 4803.3 4813.4 4856.7 4859.3 4867.4 5530.6 5533.4 5547.4 5559.3 5577.7 4102.1 4182.2 4187.5 4193.5 4196.2 5637.4 5760.8 5768.6 5782.4 5800.9 4314.0 4385.5 4397.3 4416.2 4424.3 4504.4 4514.2 4514.6 4516.3 4533.9 4651.7 4652.5 4904.5 4976.8 4977.4 5579.7 5617.4 5641.7 5670.6 5677.5 1553.3 1565.6 1568.3 1568.4 1570.3 1112.0 1117.7 1119.3 1120.0 1121.6 4871.8 4876.4 4909.8 4911.6 4912.2 5827.6 5844.3 5844.9 5847.4 5849.2 4781.5 4888.9 4898.5 4919.8 4923.8 3048.6 3072.6 3077.9 3080.0 3114.8 5333.9 5422.8 5425.6 5430.2 5447.5 5926.4 5938.6 5944.8 5955.3 5964.3 5392.7 5403.0 5412.1 5420.9 5435.5 5666.7 5761.3 5782.7 5801.9 5839.2 5683.3 5720.3 5729.5 5735.3 5754.8 5148.5 5257.3 5291.2 5376.9 5400.9 4438.8 4450.7 4460.2 4463.8 4465.9 5704.7 5815.0 5845.7 5850.7 5886.7 5576.2 5582.3 5615.2 5628.4 5629.3 5625.4 5631.4 5635.2 5641.7 5654.4 5387.2 5515.9 5524.4 5545.4 5565.2 5642.6 5647.7 5648.0 5651.5 5658.8 5464.3 5484.7 5512.9 5522.4 5530.6 06:55:28 INFO - PID 400 | 06:55:28 INFO - PID 400 | [#5] yui.html Cycles:180 Average:15389.80 Median:46647.65 stddev:19058.02 (40.9%) stddev-sans-first:19079.23 06:55:28 INFO - PID 400 | Values: 625.2 627.5 632.0 647.3 655.6 11942.5 12203.6 12237.6 12249.9 12259.8 14970.9 16255.8 16302.0 16341.5 16345.0 875.1 899.0 900.1 909.3 909.9 897.1 898.4 899.8 900.1 900.3 944.7 945.2 945.4 945.9 946.2 932.0 932.8 932.8 933.8 935.8 647.7 662.6 694.7 695.5 695.7 13533.5 13648.2 13670.9 13711.0 13770.8 13616.4 14306.5 14647.9 14695.3 14717.8 11233.7 11337.6 11419.2 11458.3 11462.1 2840.5 2861.1 2862.6 2863.9 2865.5 75230.5 75835.6 75870.6 75945.6 77572.6 12446.9 12588.4 12597.6 12601.6 12616.7 17334.6 17782.5 17962.6 18006.4 22006.3 5210.7 5739.1 6470.2 6548.6 6568.2 3035.8 3101.2 3106.4 3106.6 3111.6 3242.0 3318.6 3320.2 3334.7 3387.4 755.3 768.2 773.5 776.8 781.2 503.2 510.1 510.4 512.5 515.5 8380.7 8852.5 9027.9 9061.2 9254.8 503.4 503.5 512.0 514.9 522.4 4162.8 4165.7 4203.6 4207.7 4209.9 60830.7 62282.0 63377.4 64085.0 65277.0 56317.7 56775.4 57218.4 57346.0 59445.7 51838.7 52252.5 52343.7 52393.0 52589.5 8321.5 8375.5 8423.3 8522.2 8570.9 20165.5 25933.7 26591.9 27294.0 27558.2 46625.5 46669.8 47027.8 47057.0 47061.0 13664.7 13847.7 13948.9 14089.9 14092.1 14711.6 14795.6 14969.8 14999.3 15139.8 12644.4 12719.7 12810.9 12820.6 12903.2 13047.4 13118.0 13127.6 13333.8 13408.2 13837.3 14086.4 14151.6 14235.9 14425.4 9216.9 9434.3 9542.8 9675.0 9724.8 11219.4 11455.9 11524.7 11823.5 11958.3 06:55:28 INFO - PID 400 | -------- Summary: end -------- 06:55:28 INFO - PID 400 | 06:55:29 INFO - TEST-INFO | 400: exit 0 06:55:29 INFO - TEST-OK | dromaeo_css | took 1120732ms 06:55:29 INFO - TEST-START | kraken 06:55:29 INFO - operating with platform_type : linux_ 06:55:29 INFO - Initialising browser for kraken test... 06:55:29 INFO - TEST-INFO | started process 735 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgp22QB/profile http://localhost:38392/getInfo.html) 06:55:32 INFO - PID 735 | __metrics Screen width/height:1600/1200 06:55:32 INFO - PID 735 | colorDepth:24 06:55:32 INFO - PID 735 | Browser inner width/height: 1024/695 06:55:32 INFO - PID 735 | __metrics 06:55:33 INFO - PID 735 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:55:33 INFO - PID 735 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:55:34 INFO - TEST-INFO | 735: exit 0 06:55:34 INFO - Browser initialized. 06:55:34 INFO - Running cycle 1/1 for kraken test... 06:55:34 INFO - TEST-INFO | started process 832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgp22QB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:55:46 INFO - PID 832 | RSS: Main: 149057536 06:55:46 INFO - PID 832 | 06:55:49 INFO - PID 832 | Cycle 1(1): loaded http://localhost:38392/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38392/tests/kraken/driver.html?testName=audio-beat-detection) 06:55:50 INFO - PID 832 | RSS: Main: 221523968 06:55:50 INFO - PID 832 | 06:55:52 INFO - PID 832 | Cycle 1(1): loaded http://localhost:38392/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38392/tests/kraken/driver.html?testName=audio-dft) 06:55:53 INFO - PID 832 | RSS: Main: 182042624 06:55:53 INFO - PID 832 | 06:55:56 INFO - PID 832 | Cycle 1(1): loaded http://localhost:38392/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38392/tests/kraken/driver.html?testName=audio-fft) 06:55:57 INFO - PID 832 | RSS: Main: 263966720 06:55:57 INFO - PID 832 | 06:55:59 INFO - PID 832 | Cycle 1(1): loaded http://localhost:38392/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38392/tests/kraken/driver.html?testName=audio-oscillator) 06:55:59 INFO - PID 832 | RSS: Main: 175276032 06:55:59 INFO - PID 832 | 06:56:02 INFO - PID 832 | Cycle 1(1): loaded http://localhost:38392/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38392/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:56:02 INFO - PID 832 | RSS: Main: 177909760 06:56:02 INFO - PID 832 | 06:56:05 INFO - PID 832 | Cycle 1(1): loaded http://localhost:38392/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38392/tests/kraken/driver.html?testName=imaging-darkroom) 06:56:06 INFO - PID 832 | RSS: Main: 238194688 06:56:06 INFO - PID 832 | 06:56:10 INFO - PID 832 | Cycle 1(1): loaded http://localhost:38392/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38392/tests/kraken/driver.html?testName=imaging-desaturate) 06:56:10 INFO - PID 832 | RSS: Main: 238227456 06:56:10 INFO - PID 832 | 06:56:13 INFO - PID 832 | Cycle 1(1): loaded http://localhost:38392/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38392/tests/kraken/driver.html?testName=json-parse-financial) 06:56:14 INFO - PID 832 | RSS: Main: 235290624 06:56:14 INFO - PID 832 | 06:56:15 INFO - PID 832 | Cycle 1(1): loaded http://localhost:38392/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38392/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:56:16 INFO - PID 832 | RSS: Main: 200392704 06:56:16 INFO - PID 832 | 06:56:18 INFO - PID 832 | Cycle 1(1): loaded http://localhost:38392/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38392/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:56:18 INFO - PID 832 | RSS: Main: 205762560 06:56:18 INFO - PID 832 | 06:56:20 INFO - PID 832 | Cycle 1(1): loaded http://localhost:38392/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38392/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:56:21 INFO - PID 832 | RSS: Main: 215691264 06:56:21 INFO - PID 832 | 06:56:24 INFO - PID 832 | Cycle 1(1): loaded http://localhost:38392/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:56:25 INFO - PID 832 | RSS: Main: 223965184 06:56:25 INFO - PID 832 | 06:56:28 INFO - PID 832 | Cycle 1(1): loaded http://localhost:38392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:56:28 INFO - PID 832 | RSS: Main: 201777152 06:56:28 INFO - PID 832 | 06:56:30 INFO - PID 832 | Cycle 1(1): loaded http://localhost:38392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38392/tests/kraken/driver.html?testName=ai-astar) 06:56:30 INFO - PID 832 | RSS: Main: 270610432 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | __start_tp_report 06:56:30 INFO - PID 832 | _x_x_mozilla_page_load 06:56:30 INFO - PID 832 | _x_x_mozilla_page_load_details 06:56:30 INFO - PID 832 | |i|pagename|runs| 06:56:30 INFO - PID 832 | |0;ai-astar;108;111;113;112;111;111;111;109;113;111 06:56:30 INFO - PID 832 | |1;audio-beat-detection;151;122;123;168;123;122;122;122;150;122 06:56:30 INFO - PID 832 | |2;audio-dft;162;162;165;162;164;164;163;162;161;162 06:56:30 INFO - PID 832 | |3;audio-fft;77;74;75;110;74;78;76;76;114;76 06:56:30 INFO - PID 832 | |4;audio-oscillator;84;83;105;85;84;86;100;84;83;115 06:56:30 INFO - PID 832 | |5;imaging-gaussian-blur;112;112;113;113;113;114;113;114;113;113 06:56:30 INFO - PID 832 | |6;imaging-darkroom;149;150;149;150;149;149;150;149;150;149 06:56:30 INFO - PID 832 | |7;imaging-desaturate;94;93;95;93;93;93;93;93;94;94 06:56:30 INFO - PID 832 | |8;json-parse-financial;52;52;53;52;54;53;53;53;53;53 06:56:30 INFO - PID 832 | |9;json-stringify-tinderbox;55;56;56;56;55;55;55;55;55;55 06:56:30 INFO - PID 832 | |10;stanford-crypto-aes;83;81;82;82;81;80;81;81;80;81 06:56:30 INFO - PID 832 | |11;stanford-crypto-ccm;134;133;139;132;130;136;134;132;179;131 06:56:30 INFO - PID 832 | |12;stanford-crypto-pbkdf2;182;193;192;191;196;200;186;185;195;185 06:56:30 INFO - PID 832 | |13;stanford-crypto-sha256-iterative;74;72;74;75;73;73;72;73;72;72 06:56:30 INFO - PID 832 | __end_tp_report 06:56:30 INFO - PID 832 | __start_cc_report 06:56:30 INFO - PID 832 | _x_x_mozilla_cycle_collect,1998 06:56:30 INFO - PID 832 | __end_cc_report 06:56:30 INFO - PID 832 | __startTimestamp1494424590837__endTimestamp 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | ------- Summary: start ------- 06:56:30 INFO - PID 832 | Number of tests: 14 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:1.56 (1.4%) stddev-sans-first:1.22 06:56:30 INFO - PID 832 | Values: 108.0 111.0 113.0 112.0 111.0 111.0 111.0 109.0 113.0 111.0 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | [#1] audio-beat-detection Cycles:10 Average:132.50 Median:123.00 stddev:17.13 (13.9%) stddev-sans-first:16.81 06:56:30 INFO - PID 832 | Values: 151.0 122.0 123.0 168.0 123.0 122.0 122.0 122.0 150.0 122.0 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 06:56:30 INFO - PID 832 | Values: 162.0 162.0 165.0 162.0 164.0 164.0 163.0 162.0 161.0 162.0 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:15.36 (20.2%) stddev-sans-first:16.14 06:56:30 INFO - PID 832 | Values: 77.0 74.0 75.0 110.0 74.0 78.0 76.0 76.0 114.0 76.0 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:84.00 stddev:11.49 (13.7%) stddev-sans-first:11.92 06:56:30 INFO - PID 832 | Values: 84.0 83.0 105.0 85.0 84.0 86.0 100.0 84.0 83.0 115.0 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 06:56:30 INFO - PID 832 | Values: 112.0 112.0 113.0 113.0 113.0 114.0 113.0 114.0 113.0 113.0 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 06:56:30 INFO - PID 832 | Values: 149.0 150.0 149.0 150.0 149.0 149.0 150.0 149.0 150.0 149.0 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:93.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 06:56:30 INFO - PID 832 | Values: 94.0 93.0 95.0 93.0 93.0 93.0 93.0 93.0 94.0 94.0 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:0.63 (1.2%) stddev-sans-first:0.60 06:56:30 INFO - PID 832 | Values: 52.0 52.0 53.0 52.0 54.0 53.0 53.0 53.0 53.0 53.0 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 06:56:30 INFO - PID 832 | Values: 55.0 56.0 56.0 56.0 55.0 55.0 55.0 55.0 55.0 55.0 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:0.92 (1.1%) stddev-sans-first:0.71 06:56:30 INFO - PID 832 | Values: 83.0 81.0 82.0 82.0 81.0 80.0 81.0 81.0 80.0 81.0 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:134.00 stddev:14.64 (10.9%) stddev-sans-first:15.45 06:56:30 INFO - PID 832 | Values: 134.0 133.0 139.0 132.0 130.0 136.0 134.0 132.0 179.0 131.0 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.50 Median:192.50 stddev:5.80 (3.0%) stddev-sans-first:5.27 06:56:30 INFO - PID 832 | Values: 182.0 193.0 192.0 191.0 196.0 200.0 186.0 185.0 195.0 185.0 06:56:30 INFO - PID 832 | 06:56:30 INFO - PID 832 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:73.00 stddev:1.05 (1.4%) stddev-sans-first:1.05 06:56:30 INFO - PID 832 | Values: 74.0 72.0 74.0 75.0 73.0 73.0 72.0 73.0 72.0 72.0 06:56:30 INFO - PID 832 | -------- Summary: end -------- 06:56:30 INFO - PID 832 | 06:56:31 INFO - TEST-INFO | 832: exit 0 06:56:32 INFO - TEST-OK | kraken | took 62685ms 06:56:32 INFO - SUITE-END | took 1183s 06:56:32 INFO - Completed test suite (00:19:43) 06:56:32 INFO - javascript benchmark 06:56:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6613.541112032177, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2704.7565719085283, 2708.7832973362133, 2738.4386200828826, 2748.7251274872515, 2748.793840461966, 5122.052420302238, 5243.554297884684, 5259.421463639002, 5290.0477913975465, 5308.575313974878, 5192.610554208431, 5194.194899790529, 5202.843914682556, 5216.478352164781, 5224.92162617561, 4626.028534007863, 4651.488336283006, 4656.790444430008, 4682.642033810191, 4697.271922851964, 4687.6952998055185, 4708.529147085281, 4719.386479757627, 4727.479977202505, 4734.644901632374, 4700.858974230779, 4709.929351059737, 4713.43438787346, 4713.740744259065, 4714.811407543694, 4704.059188162381, 4706.294055891643, 4708.529147085298, 4708.952910470885, 4710.152172608929, 4581.725096494221, 4612.238980568202, 4661.650376221797, 4681.625469962395, 4710.29345598163, 5196.506331898464, 5213.635045546814, 5236.554892834114, 5250.7637156328055, 5309.469053094698, 5603.719814009283, 5620.325560932714, 5628.0713682242385, 5646.124850648156, 5688.033034384164, 5085.415177254589, 5529.695866727328, 5532.7786888524415, 5564.888702225973, 5568.832935011957, 5253.395859476209, 5269.262303277545, 5306.124489459196, 5308.177232528964, 5312.574994000471, 5798.623089499169, 5808.506276966421, 5812.534997200214, 5822.388649191774, 5834.970825145847, 5430.049741295336, 5522.6134170608475, 5525.226468294442, 5541.722913854291, 5548.250986116904, 5532.197831314517, 5547.25112109868, 5608.971955140199, 5638.323401191883, 5649.830505084854, 5564.248826408383, 5595.664260144405, 5604.3835178130375, 5604.97197514018, 5606.635568688022, 5529.889402212014, 5539.058360078716, 5586.748596313095, 5596.048671725816, 5601.5238704710555, 4501.572350626685, 4546.249868771682, 4555.202839503074, 4615.676902616851, 4626.514216007338, 3940.2907476653904, 3977.8607748728655, 3981.6018398159954, 3985.501812273466, 4025.355943049098, 4764.714117152982, 4807.894184337552, 4815.831445899446, 4833.661643684979, 4859.198232291632, 5558.0, 5564.026295398289, 5625.662460252316, 5627.8593035174445, 5698.430156984351, 4770.95229047712, 4811.591014763714, 4812.0, 4814.807407703723, 4818.4217893852965, 4993.300937868701, 4998.025385049953, 5001.299818025479, 5005.74971251436, 5007.9499205008215, 5208.843734688041, 5228.816991405282, 5229.764660590206, 5230.660007099526, 5232.581393488588, 5609.971950140223, 5649.209110724584, 5652.378238393856, 5655.519280861008, 5657.8019769307875, 5222.686638801684, 5228.085085110014, 5231.738413079407, 5234.11020126587, 5235.4764523548865, 5541.584381171348, 5545.556355491632, 5553.6390134641115, 5559.4162612926675, 5564.693941833076, 5598.384177740527, 5608.579356548356, 5608.831735047955, 5616.887662246814, 5675.0, 5400.675959442446, 5469.808556700496, 5488.4237155098135, 5489.505944465017, 5543.279373681396, 5408.567314614743, 5466.808661696821, 5467.781288748405, 5495.368032676293, 5520.861978450571, 5402.6758394496455, 5430.104032834538, 5432.945670543402, 5434.239206511171, 5436.537894278872, 5425.945740542702, 5535.363433205233, 5539.086050801573, 5551.195076713934, 5607.130894711327, 5315.096433606219, 5315.840524784263, 5378.193271009223, 5378.7579558920725, 5435.456454354533], "value": 5098.5160232043645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.3594513322079, 714.4355958792553, 722.3101937649543, 923.870658107865, 942.1897168435149, 24003.399915002134, 32019.19952001198, 32605.510917336258, 32684.182895427628, 32684.509732354032, 34380.65619343806, 34839.0, 34869.12827179322, 34871.82564087176, 34894.82552587234, 5383.327084114486, 5526.751296191661, 6989.231184569693, 7161.606111663857, 7165.319294666998, 6383.776567820128, 7101.644917754117, 7122.9287707122785, 7123.074000379944, 7128.6079265640365, 7114.146302443688, 7213.458990575701, 7222.530535515201, 7232.746853860116, 7240.746573869916, 7171.820704482404, 7175.569465832067, 7230.674619642129, 7233.565986040854, 7233.927660723431, 6977.755778547727, 7030.578165310098, 7043.190033146203, 7048.541844780073, 7051.365377116084, 32267.51598726021, 32464.837675811705, 32479.675203248138, 32484.18789530257, 32501.674983250337, 3071.0, 3073.0319949215927, 3096.9535456968165, 3106.0, 3111.6110486189227, 24120.0, 24229.0, 24262.757372426226, 24290.271291861096, 24332.0, 3188.0595224408853, 3207.3104282579125, 3226.9031929042167, 3229.11199420159, 3240.0, 139014.99999999898, 139461.0, 139479.0, 139763.0, 139855.0, 40742.388864167064, 40809.0, 40851.38722919158, 40904.38643420351, 40940.79529602333, 42117.78941105336, 42139.15721685549, 42185.0, 42200.57799421967, 42255.7887210562, 12609.180403273758, 12681.873181268069, 12682.49270029207, 12719.427625756864, 12735.23588584688, 8023.759287221393, 8143.348532117417, 10194.643187488402, 10207.693769186937, 10248.38509689406, 10855.348679079281, 10952.288101273392, 10955.287906286067, 11992.580259690869, 12233.816492752616, 4821.960276465605, 4870.788662939236, 4919.877003074952, 4968.652194346361, 4997.675151115166, 887.2680038967877, 888.0941439731438, 904.0959040959041, 908.3641450984205, 913.9725808225763, 20678.379648610568, 20827.8958605206, 21071.578568428544, 21167.0, 21396.144154233967, 978.3787295067683, 980.4313498171043, 995.6017592962872, 1005.5927349423495, 1007.6573964851985, 10501.422421766876, 11191.888081119085, 11243.156763242789, 11255.099592032619, 11338.206325557298, 161839.19080404524, 161842.0, 161994.4703594286, 162080.0, 162189.18905405398, 39896.40155397671, 40034.79982600127, 40081.39877901834, 40207.798961005596, 40211.0, 1208.528673817212, 1232.5439587352557, 1236.771197328497, 1239.659093749208, 1251.1992324912064, 19721.211151553776, 19729.506762331057, 20206.29277975264, 20965.475863103544, 21250.89374553117, 29153.85423072871, 29189.270268243465, 29202.123936281947, 29215.393153376768, 29229.415411692073, 150516.0, 150518.49481505482, 150682.24658877074, 151070.0, 151350.24324878305, 28794.42411151807, 29105.563416549194, 29244.56133158047, 29332.70667293385, 29411.0, 29569.0, 30220.0, 34370.484442733876, 34707.0, 36015.459768104025, 25495.0, 25815.483690325713, 25816.741832581432, 26265.4746905057, 27483.17550473489, 26698.86650566735, 26825.86587067052, 27003.459930801666, 27189.0, 27513.31216719598, 29173.7082629171, 29284.414311714074, 29322.120336389944, 29335.413291734472, 29376.55935161017, 24877.626835597843, 25935.09227177115, 25984.8700756495, 34612.480812787326, 35119.47320790241, 25896.741032589434, 25916.740832591433, 27151.0, 27842.860785695942, 28864.42271154523], "value": 14326.010884859996, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.9231849789292, 395.3950455802623, 412.04611324783133, 416.8061851239173, 431.34220314021115, 16050.759238611401, 17046.82953170468, 17536.912315438436, 17674.64650706987, 17681.0, 17604.735928961043, 18017.459476215703, 18161.63676726468, 18266.269349226048, 18425.631487370243, 5159.174532074869, 5175.068487672236, 5314.388845282784, 5397.298351214336, 5404.945950540484, 5235.293235413227, 5325.840224793263, 5332.680039197641, 5333.946660533384, 5334.813281535147, 5140.997505486432, 5195.532402083812, 5310.07073762092, 5320.973395133019, 5326.334208223972, 5261.789528418878, 5299.576033917316, 5308.150695888678, 5308.92036619451, 5313.362396512443, 4574.153781550423, 4719.07977944301, 4752.310914917318, 4767.880802979953, 4771.188897887333, 20905.163793448242, 20959.16163353464, 20963.371098866905, 21123.15507379703, 21136.577268454697, 1632.3633782824709, 1661.567992321993, 1662.8087769906494, 1662.8919120257144, 1664.6171380582414, 13816.516421925184, 14325.140491570435, 14624.976251662389, 14680.504314266493, 14916.552503424915, 2038.5311378382908, 2045.2228153301799, 2095.8008989146006, 2103.4846462616606, 2118.9046492907855, 78533.60733196298, 79285.0, 79987.60006199931, 80396.59801701012, 82426.17573824245, 10103.393796372242, 10137.290389672653, 10249.84625230622, 10389.467581022489, 10395.272330936914, 14220.146791192561, 14295.07082039664, 14347.139171649735, 14351.138931664134, 14380.280985950661, 7006.894896576556, 7226.747063852845, 7267.30960558746, 7357.852842943111, 7408.518446300973, 6727.495437842182, 6752.831179220559, 6907.378335949788, 6927.826804329932, 6939.757108501179, 6489.3510648934725, 6642.767503137367, 6646.468282537386, 6675.46596272297, 6755.7973260802255, 1773.485689150132, 1792.2203841329062, 1807.168702396886, 1817.0732926207465, 1844.0963927675343, 873.7553485024204, 887.2680038967749, 891.2424439226735, 896.8834051573384, 900.2842740021698, 16148.596285092732, 16389.0, 16467.58831029234, 16568.254428550743, 17291.308347666203, 880.4365206267994, 893.4091135706503, 901.5221932375852, 908.7364664247426, 919.4253591505309, 8733.81215856208, 9025.63897444108, 9130.497822619687, 9433.39632262517, 9512.28657850664, 320609.0, 338397.0, 338787.0, 339145.0, 339902.0, 73262.63368683122, 74782.62608687031, 76294.61852690701, 76434.61782691051, 80155.0, 1056.5826498533036, 1073.0, 1077.127526703357, 1083.7019819549687, 1085.4247248958065, 14174.0, 14183.361748721127, 14301.92849035748, 14306.928465357607, 14673.853261467675, 38016.239675206896, 38360.86226203794, 38439.0, 38837.6116238834, 39403.0, 46091.539084608725, 46181.30728039015, 46305.53694463012, 46358.30462543132, 48993.020139596294, 7597.354224890946, 7599.582022988789, 7810.531368117931, 7842.803929901798, 7843.548943445481, 11601.825972610586, 12235.510579577074, 12435.37823108859, 12679.429425675682, 12716.682082948, 10340.844887326546, 10381.0, 10533.315334503233, 10898.291611045257, 10949.56201751921, 9428.0, 9718.854217186888, 9863.112319891245, 9901.158401535662, 9922.107010369102, 10625.043746062891, 10671.0, 10910.345379277269, 11083.224174307721, 11112.666620001413, 7668.616569171408, 7685.577293248925, 7809.609519524115, 7895.052593688794, 7961.761147165595, 10777.784444311226, 11009.504572294105, 11010.944945275543, 11267.718307042389, 11403.714907127389], "value": 8494.821976955827, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1137.4710759496832, 1257.50328620195, 1299.8115273285373, 1314.986850131499, 1330.4212667489642, 8612.354073444494, 9707.271954603397, 10235.846462303061, 10284.023017813295, 10286.691399258016, 10044.899551004488, 10148.49257537122, 10161.136303414218, 10165.339252948554, 10183.694489165337, 1887.5375532994435, 2252.5157091225424, 2301.3211102724654, 2301.7698230177016, 2301.850379725321, 1942.5435022769639, 2211.181862710799, 2296.150424342987, 2300.9424764380856, 2310.6765052892524, 2232.162938897913, 2244.382794731454, 2255.4474153832252, 2256.8533045352, 2257.841951063426, 2105.705201271823, 2111.123883588309, 2112.915483380663, 2115.714378558898, 2119.2900378373265, 2157.46063484129, 2171.5873983943, 2178.575177840322, 2179.7929196726445, 2180.563887222562, 9995.300328976975, 10023.799524009552, 10065.597376104946, 10087.445190514518, 10091.798164036678, 5660.320761508646, 5888.5877988540815, 5895.322037965646, 5897.351291357947, 5898.439648233411, 3145.905622831319, 3330.2673411849355, 3391.1522119470133, 3394.8642054317797, 3395.5416018837386, 1080.6541906589894, 1083.1767856429092, 1118.6644006797928, 1144.5307423956222, 1149.5976408257127, 14741.631459213499, 14763.26183690822, 14774.556763297118, 14775.335109920079, 14855.554333370017, 5084.8220312288895, 5088.236764485357, 5218.817341393033, 5390.838274851761, 5398.62209645321, 12544.184627999151, 12570.434330455151, 12570.560030398892, 12571.74856502883, 12593.559225427067, 5882.588218824641, 5898.852528686817, 5906.173135760997, 5911.881762364728, 5916.5858389913155, 5281.656692314988, 5352.785888564414, 5368.114261146867, 5371.704556249366, 5394.379646340721, 4212.199682060399, 4269.124829410026, 4338.197433474817, 4344.3049112142535, 4363.454568178978, 1343.3350491506767, 1365.7336819320335, 1367.3915107776943, 1379.1793882639813, 1388.5834249725042, 661.7319985405918, 690.730615060127, 692.504859025799, 705.7988473285089, 713.165596252386, 5445.754941027663, 5532.778688852401, 5535.667859928417, 5629.746661400247, 5700.8004719835435, 551.7020808763303, 561.8201776269882, 566.8752874367633, 567.0473604344658, 569.5728203847115, 3101.705337992887, 3119.625644922624, 3193.377291428196, 3196.568463257477, 3213.4697774867354, 12575.811362829565, 13404.128731632412, 13512.121712088683, 13542.932285338511, 13550.035244889435, 13242.602721918358, 13257.138286011379, 13409.262490562918, 13410.530631428048, 13488.190708557519, 7652.354743730125, 7765.495242809199, 7891.408144389194, 7905.169957154531, 7994.84010319802, 5649.350324712546, 5710.3433105193435, 5760.366359700346, 5797.8550536236935, 5906.557008224315, 11766.941165294118, 11821.231619944676, 11906.166568340133, 11935.52257909674, 11967.700807479883, 11248.887511124783, 12272.570460033856, 12362.75274494523, 12473.563425280072, 12476.251424914533, 7307.598082105323, 7777.716676748273, 7843.450958432855, 7844.333231675143, 7972.960135199287, 9568.043195680377, 9646.0, 9675.467849268358, 9705.708828735149, 9839.409635421898, 8214.219649133323, 8255.298299644357, 8283.0, 8315.542645154575, 8434.493930364199, 7967.28294453502, 7969.0, 7986.241307075818, 8185.976752905886, 8194.22154895284, 7655.46411751172, 7665.770026899202, 7718.112417072109, 7748.690052397841, 7787.260210280015, 4968.701877887338, 5118.257852611276, 5126.512981266774, 5139.511746384088, 5144.614153938394, 4938.851834444972, 4971.726555039363, 4996.975015125046, 5016.673916195436, 5055.393352797688], "value": 4731.952828483878, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.70608631353844, 384.2257850431381, 386.0503162220936, 388.81336958260033, 392.5720964149077, 5316.5215130638235, 5328.973355133224, 5342.439043900393, 5353.785848566057, 5356.223347614594, 5173.896522069556, 5195.532402083812, 5237.742941693995, 5257.395399529055, 5260.736963151837, 4149.751014939098, 4159.126583417471, 4160.209560183571, 4173.290540608089, 4176.227397931377, 4163.333866581347, 4165.520965089008, 4171.103212809246, 4172.18509948172, 4175.979120104395, 4061.1268577255883, 4146.834126634931, 4153.8161623937185, 4155.667546596265, 4165.6250937415625, 4112.943528235882, 4129.359949207847, 4136.338185890243, 4136.379543068534, 4155.501339839208, 3717.2937141943216, 3731.365667836474, 3736.3461394255896, 3737.3272810894027, 3742.1954279829697, 4984.551390374847, 5121.0, 5159.406668233164, 5169.276301317818, 5176.249443830661, 4803.255495398219, 4813.3983252093485, 4856.732879691615, 4859.34398856157, 4867.415910090776, 5530.557555395559, 5533.418991005927, 5547.44525547446, 5559.33288005442, 5577.665340079568, 4102.118044620421, 4182.163567286555, 4187.539370669224, 4193.454850869368, 4196.160767846412, 5637.379888212294, 5760.798372056958, 5768.625039372428, 5782.421757824268, 5800.854978625526, 4314.0, 4385.451818522684, 4397.31841564558, 4416.24923762961, 4424.336349547593, 4504.3919070925, 4514.210013247734, 4514.616257618073, 4516.299973504112, 4533.9319910201375, 4651.651126165483, 4652.534746525388, 4904.493287299527, 4976.825811096594, 4977.427595826526, 5579.69311687861, 5617.41017193197, 5641.661500309912, 5670.603057785916, 5677.460641239076, 1553.2932515705327, 1565.6164239761104, 1568.317781764936, 1568.4196847166393, 1570.3404570080593, 1111.9833202501968, 1117.6870476266658, 1119.2948442481186, 1119.9552017919193, 1121.6354684727496, 4871.756412179377, 4876.414830220397, 4909.828156014522, 4911.631627627942, 4912.164931961575, 5827.619980411436, 5844.327902291291, 5844.8538786529825, 5847.415258474203, 5849.151872978395, 4781.545753153445, 4888.875558621537, 4898.53463920927, 4919.827806026772, 4923.8276660316715, 3048.6189226346705, 3072.6005619269354, 3077.861496232675, 3079.9538006929915, 3114.8131112133347, 5333.946660533423, 5422.8373148805595, 5425.5856144016325, 5430.15832545956, 5447.455254474521, 5926.407359264039, 5938.554608404387, 5944.768603628779, 5955.255593050869, 5964.314103878023, 5392.703401312965, 5402.972985135128, 5412.134058550613, 5420.9186862197885, 5435.483629055233, 5666.716664166857, 5761.279840019997, 5782.739776710142, 5801.854953626024, 5839.240898683144, 5683.261176047087, 5720.313562372542, 5729.512991395778, 5735.311762588516, 5754.827355179351, 5148.510891465305, 5257.342832145981, 5291.1798671206025, 5376.919346209888, 5400.891982160413, 4438.800253988643, 4450.666200035075, 4460.1971645104195, 4463.799129039266, 4465.933011004772, 5704.714764261853, 5814.970925145347, 5845.736941837543, 5850.7074646266665, 5886.676232807236, 5576.219329293821, 5582.330120385417, 5615.157726341082, 5628.352739434854, 5629.268195134607, 5625.437456254342, 5631.352394474688, 5635.154726791015, 5641.717914104361, 5654.378018417889, 5387.191921211849, 5515.944840551543, 5524.4199359066715, 5545.445455454584, 5565.193047008081, 5642.633228840113, 5647.7176141193595, 5648.0, 5651.547876169814, 5658.773649053992, 5464.3442786865835, 5484.698341591251, 5512.91730624033, 5522.392536820867, 5530.6128570999645], "value": 4308.902423807533, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [625.2153547298141, 627.5293529852611, 631.9602710960281, 647.3461803578385, 655.6361219523163, 11942.522299108035, 12203.633890983263, 12237.571684991039, 12249.938750306235, 12259.754804903896, 14970.850291497081, 16255.837441625581, 16302.0, 16341.509754707378, 16345.0, 875.0593112404159, 898.9820203595924, 900.1403659505189, 909.3089252168334, 909.8953620333647, 897.1208215948375, 898.4115404410122, 899.7750562359411, 900.1178844732134, 900.3247564326755, 944.7496413450441, 945.1824172091126, 945.4469135555709, 945.8864936207631, 946.1673727120125, 932.0260327957301, 932.7947851472666, 932.8087742012905, 933.785229397239, 935.7567032571546, 647.744141064277, 662.6454846657016, 694.6735034533812, 695.4679670052413, 695.6521739130435, 13533.526326578523, 13648.249346285951, 13670.93164534171, 13711.0, 13770.793438098437, 13616.38726257311, 14306.499272525516, 14647.92676036613, 14695.33870975798, 14717.779233311509, 11233.66299011031, 11337.603183888525, 11419.200655954086, 11458.312501249951, 11462.083033357394, 2840.5029119904143, 2861.141657502741, 2862.5563037729185, 2863.9284017899718, 2865.498537755905, 75230.46773451721, 75835.62082189554, 75870.62064689696, 75945.62027189828, 77572.61213693951, 12446.937765311115, 12588.4335204916, 12597.559085431965, 12601.621951341474, 12616.74766504683, 17334.566635834206, 17782.466526004242, 17962.64074718498, 18006.369777058004, 22006.339809805733, 5210.739463026834, 5739.110437882135, 6470.1588793457495, 6548.639824809586, 6568.244651865001, 3035.7874948753374, 3101.2246938265434, 3106.378724255158, 3106.5650808886776, 3111.642161151451, 3241.9837900810817, 3318.5519954806273, 3320.1533608929567, 3334.699877011032, 3387.3733359328603, 755.2938002967243, 768.1933969332179, 773.5126870071819, 776.7863837444635, 781.2265856801725, 503.17730510615405, 510.1124044163204, 510.4232217594095, 512.5489569179173, 515.4613428966738, 8380.664773409117, 8852.468851868909, 9027.864582031274, 9061.229795467327, 9254.768630784285, 503.413523245415, 503.45878180955617, 511.97696103675423, 514.8892988007597, 522.4148953172471, 4162.772916489664, 4165.66674666026, 4203.642690371353, 4207.726497777696, 4209.852655157116, 60830.69435978292, 62282.0, 63377.36622633807, 64085.0, 65277.0, 56317.71841140768, 56775.43224567784, 57218.42781572214, 57346.0, 59445.70277148586, 51838.740806295726, 52252.47747522476, 52343.73828130835, 52393.0, 52589.47410525922, 8321.500709957421, 8375.539345336065, 8423.284020858051, 8522.190391912758, 8570.871436928326, 20165.49586260355, 25933.740662593886, 26591.867040664674, 27294.0, 27558.173254802387, 46625.53374466212, 46669.76665116653, 47027.76486117548, 47057.0, 47061.0, 13664.65838354049, 13847.653808654864, 13948.860511394756, 14089.929550352183, 14092.084014539432, 14711.632209194855, 14795.630109247355, 14969.77545336799, 14999.325030373877, 15139.772903406238, 12644.367781611067, 12719.682007949876, 12810.87189128134, 12820.61538153857, 12903.161294515827, 13047.412866420844, 13118.0, 13127.606171814861, 13333.799993000306, 13408.195508269535, 13837.308134593432, 14086.36611352512, 14151.575452736435, 14235.928820355832, 14425.42298308056, 9216.907830921606, 9434.339596228197, 9542.809143817223, 9674.951625241829, 9724.75688107803, 11219.439028048728, 11455.942720286344, 11524.711882203012, 11823.467943942715, 11958.342291173722], "value": 6613.67866928451, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 113.0, 112.0, 111.0, 111.0, 111.0, 109.0, 113.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 123.0, 168.0, 123.0, 122.0, 122.0, 122.0, 150.0, 122.0], "value": 132.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 165.0, 162.0, 164.0, 164.0, 163.0, 162.0, 161.0, 162.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 75.0, 110.0, 74.0, 78.0, 76.0, 76.0, 114.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 105.0, 85.0, 84.0, 86.0, 100.0, 84.0, 83.0, 115.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 150.0, 149.0, 149.0, 150.0, 149.0, 150.0, 149.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 95.0, 93.0, 93.0, 93.0, 93.0, 93.0, 94.0, 94.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 52.0, 54.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 82.0, 82.0, 81.0, 80.0, 81.0, 81.0, 80.0, 81.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 139.0, 132.0, 130.0, 136.0, 134.0, 132.0, 179.0, 131.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 193.0, 192.0, 191.0, 196.0, 200.0, 186.0, 185.0, 195.0, 185.0], "value": 190.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 74.0, 75.0, 73.0, 73.0, 72.0, 73.0, 72.0, 72.0], "value": 73.0, "unit": "score"}]}]} 06:56:32 INFO - Return code: 0 06:56:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:56:32 INFO - # TBPL SUCCESS # 06:56:32 INFO - Running post-action listener: _resource_record_post_action 06:56:32 INFO - [mozharness: 2017-05-10 13:56:32.625544Z] Finished run-tests step (success) 06:56:32 INFO - Running post-run listener: _resource_record_post_run 06:56:32 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 359567360; Read time: 16; Write time: 214948 06:56:32 INFO - TinderboxPrint: CPU usage
12.9% 06:56:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:56:32 INFO - TinderboxPrint: I/O write bytes / time
359,567,360 / 214,948 06:56:32 INFO - TinderboxPrint: CPU idle
8,339.9 (87.1%) 06:56:32 INFO - TinderboxPrint: CPU user
1,196.1 (12.5%) 06:56:32 INFO - TinderboxPrint: Swap in / out
0 / 0 06:56:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106135552; Read time: 0; Write time: 96036 06:56:32 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 252866560; Read time: 0; Write time: 118884 06:56:33 INFO - Running post-run listener: _upload_blobber_files 06:56:33 INFO - Blob upload gear active. 06:56:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:56:33 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 06:56:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:56:33 INFO - (blobuploader) - INFO - Open directory for files ... 06:56:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:56:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:56:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:34 INFO - (blobuploader) - INFO - Done attempting. 06:56:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:56:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:56:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:35 INFO - (blobuploader) - INFO - Done attempting. 06:56:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:56:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:56:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:36 INFO - (blobuploader) - INFO - Done attempting. 06:56:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:56:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:56:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:56:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:56:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:56:39 INFO - (blobuploader) - INFO - Done attempting. 06:56:39 INFO - (blobuploader) - INFO - Iteration through files over. 06:56:39 INFO - Return code: 0 06:56:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:56:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:56:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a808a6b30beeb64c047add3c433ce3ed133b350ff2a968bb0a4180bb92bb2a6d6af3563c6c81f260ca8c3a26231c46353be1de2da20da059f6067e4661cdf060", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/570f497cd49c4605b18f410c227de1f4c1b25b778d90ea27b5a9656d8aafad58bcfe569c7431d74adc4feca2d071c6087c169225272b071313d24a9e6be3a01d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43dbeff6e9ecd20f1f55b3527333e41c7e4bf6798f69753c3f2ba510ad2e6577dbd0d0704386cb51953b0ac29b13feea6d7890f635cff96c2b00dff979002ea8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72c803e8d90402d491a7f420b0d194c5434d668fb0b95bde454b1f63016e5f4a9e36df4c705c73659dd1568653dbb986fa80f33bd8a6e6cbf6393ac89cf0f5df"} 06:56:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:56:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:56:39 INFO - Contents: 06:56:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a808a6b30beeb64c047add3c433ce3ed133b350ff2a968bb0a4180bb92bb2a6d6af3563c6c81f260ca8c3a26231c46353be1de2da20da059f6067e4661cdf060", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/570f497cd49c4605b18f410c227de1f4c1b25b778d90ea27b5a9656d8aafad58bcfe569c7431d74adc4feca2d071c6087c169225272b071313d24a9e6be3a01d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43dbeff6e9ecd20f1f55b3527333e41c7e4bf6798f69753c3f2ba510ad2e6577dbd0d0704386cb51953b0ac29b13feea6d7890f635cff96c2b00dff979002ea8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72c803e8d90402d491a7f420b0d194c5434d668fb0b95bde454b1f63016e5f4a9e36df4c705c73659dd1568653dbb986fa80f33bd8a6e6cbf6393ac89cf0f5df"} 06:56:39 INFO - Running post-run listener: copy_logs_to_upload_dir 06:56:39 INFO - Copying logs to upload dir... 06:56:39 INFO - mkdir: /builds/slave/test/build/upload/logs 06:56:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.721394 ========= master_lag: -0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-10 06:56:39.502410) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 06:56:39.508826) ========= 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=0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a808a6b30beeb64c047add3c433ce3ed133b350ff2a968bb0a4180bb92bb2a6d6af3563c6c81f260ca8c3a26231c46353be1de2da20da059f6067e4661cdf060", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/570f497cd49c4605b18f410c227de1f4c1b25b778d90ea27b5a9656d8aafad58bcfe569c7431d74adc4feca2d071c6087c169225272b071313d24a9e6be3a01d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43dbeff6e9ecd20f1f55b3527333e41c7e4bf6798f69753c3f2ba510ad2e6577dbd0d0704386cb51953b0ac29b13feea6d7890f635cff96c2b00dff979002ea8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72c803e8d90402d491a7f420b0d194c5434d668fb0b95bde454b1f63016e5f4a9e36df4c705c73659dd1568653dbb986fa80f33bd8a6e6cbf6393ac89cf0f5df"} build_url:https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/C-8W5w8iT-ikMnRjWDqBYQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a808a6b30beeb64c047add3c433ce3ed133b350ff2a968bb0a4180bb92bb2a6d6af3563c6c81f260ca8c3a26231c46353be1de2da20da059f6067e4661cdf060", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/570f497cd49c4605b18f410c227de1f4c1b25b778d90ea27b5a9656d8aafad58bcfe569c7431d74adc4feca2d071c6087c169225272b071313d24a9e6be3a01d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43dbeff6e9ecd20f1f55b3527333e41c7e4bf6798f69753c3f2ba510ad2e6577dbd0d0704386cb51953b0ac29b13feea6d7890f635cff96c2b00dff979002ea8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72c803e8d90402d491a7f420b0d194c5434d668fb0b95bde454b1f63016e5f4a9e36df4c705c73659dd1568653dbb986fa80f33bd8a6e6cbf6393ac89cf0f5df"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-10 06:56:39.537061) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:56:39.537354) ========= 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=0333a256a5e4f052382dd180000001b1-1494423343.456890-1647269796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004789 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-10 06:56:39.617926) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 06:56:39.618217) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-10 06:56:39.618514) ========= ========= Total master_lag: 0.08 =========